builder: b2g-inbound_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-017 starttime: 1447657115.14 results: success (0) buildid: 20151115203128 builduid: 3982465e336c4745823a36ee7ed01193 revision: 91245e9464943de25c76f2aacdca1b1976eabb87 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-11-15 22:58:35.136506) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-11-15 22:58:35.137230) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-15 22:58:35.137571) ========= 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=6587686cb2da90a5f91b3170000001be-1447655857.723338-17557532 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006690 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-15 22:58:35.160172) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-15 22:58:35.160714) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-15 22:58:35.244909) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-15 22:58:35.245342) ========= 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=6587686cb2da90a5f91b3170000001be-1447655857.723338-17557532 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004618 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-15 22:58:35.301498) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-15 22:58:35.301773) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-15 22:58:35.302153) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-15 22:58:35.302433) ========= 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=6587686cb2da90a5f91b3170000001be-1447655857.723338-17557532 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-11-15 22:58:35-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 225M=0s 2015-11-15 22:58:35 (225 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.104932 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-15 22:58:35.420163) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-15 22:58:35.420527) ========= 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=6587686cb2da90a5f91b3170000001be-1447655857.723338-17557532 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.022169 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-15 22:58:35.469676) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-15 22:58:35.470044) ========= bash -c 'python archiver_client.py mozharness --repo integration/b2g-inbound --rev 91245e9464943de25c76f2aacdca1b1976eabb87 --destination scripts --debug' in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/b2g-inbound --rev 91245e9464943de25c76f2aacdca1b1976eabb87 --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=6587686cb2da90a5f91b3170000001be-1447655857.723338-17557532 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-11-15 22:58:35,709 truncating revision to first 12 chars 2015-11-15 22:58:35,709 Setting DEBUG logging. 2015-11-15 22:58:35,709 attempt 1/10 2015-11-15 22:58:35,709 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/b2g-inbound/91245e946494?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-11-15 22:58:35,971 unpacking tar archive at: b2g-inbound-91245e946494/testing/mozharness/ program finished with exit code 0 elapsedTime=0.549395 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-15 22:58:36.032481) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-15 22:58:36.032794) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-15 22:58:36.042496) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-15 22:58:36.042821) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-15 22:58:36.043669) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 55 secs) (at 2015-11-15 22:58:36.043977) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name B2G-Inbound --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch B2G-Inbound 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', 'B2G-Inbound', '--system-bits', '64', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'B2G-Inbound'] 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=6587686cb2da90a5f91b3170000001be-1447655857.723338-17557532 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 22:58:36 INFO - MultiFileLogger online at 20151115 22:58:36 in /builds/slave/test-pgo 22:58:36 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name B2G-Inbound --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch B2G-Inbound 22:58:36 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 22:58:36 INFO - {'append_to_log': False, 22:58:36 INFO - 'base_work_dir': '/builds/slave/test-pgo', 22:58:36 INFO - 'blob_upload_branch': 'B2G-Inbound', 22:58:36 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 22:58:36 INFO - 'branch': 'B2G-Inbound', 22:58:36 INFO - 'buildbot_json_path': 'buildprops.json', 22:58:36 INFO - 'config_files': ('talos/linux_config.py',), 22:58:36 INFO - 'default_actions': ('clobber', 22:58:36 INFO - 'read-buildbot-config', 22:58:36 INFO - 'download-and-extract', 22:58:36 INFO - 'populate-webroot', 22:58:36 INFO - 'create-virtualenv', 22:58:36 INFO - 'install', 22:58:36 INFO - 'run-tests'), 22:58:36 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 22:58:36 INFO - 'download_minidump_stackwalk': True, 22:58:36 INFO - 'download_symbols': 'ondemand', 22:58:36 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 22:58:36 INFO - 'tooltool.py': '/tools/tooltool.py', 22:58:36 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 22:58:36 INFO - '/tools/misc-python/virtualenv.py')}, 22:58:36 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 22:58:36 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 22:58:36 INFO - 'installer_path': 'installer.exe', 22:58:36 INFO - 'log_level': 'info', 22:58:36 INFO - 'log_name': 'talos', 22:58:36 INFO - 'log_to_console': True, 22:58:36 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 22:58:36 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 22:58:36 INFO - 'opt_config_files': (), 22:58:36 INFO - 'pip_index': False, 22:58:36 INFO - 'sps_profile': False, 22:58:36 INFO - 'sps_profile_interval': 0, 22:58:36 INFO - 'suite': 'dromaeojs', 22:58:36 INFO - 'system_bits': '64', 22:58:36 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 22:58:36 INFO - 'title': 'talos-linux64-ix-017', 22:58:36 INFO - 'tooltool_cache': '/builds/tooltool_cache', 22:58:36 INFO - 'use_talos_json': True, 22:58:36 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 22:58:36 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 22:58:36 INFO - 'work_dir': 'build'} 22:58:36 INFO - ##### 22:58:36 INFO - ##### Running clobber step. 22:58:36 INFO - ##### 22:58:36 INFO - Running pre-action listener: _resource_record_pre_action 22:58:36 INFO - Running main action method: clobber 22:58:36 INFO - rmtree: /builds/slave/test-pgo/build 22:58:36 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 22:58:37 INFO - Running post-action listener: _resource_record_post_action 22:58:37 INFO - ##### 22:58:37 INFO - ##### Running read-buildbot-config step. 22:58:37 INFO - ##### 22:58:37 INFO - Running pre-action listener: _resource_record_pre_action 22:58:37 INFO - Running main action method: read_buildbot_config 22:58:37 INFO - Using buildbot properties: 22:58:37 INFO - { 22:58:37 INFO - "properties": { 22:58:37 INFO - "buildnumber": 970, 22:58:37 INFO - "product": "firefox", 22:58:37 INFO - "script_repo_revision": "production", 22:58:37 INFO - "builddir": "b2g-inbound_ubuntu64_hw_test-dromaeojs", 22:58:37 INFO - "repository": "", 22:58:37 INFO - "buildername": "Ubuntu HW 12.04 x64 b2g-inbound pgo talos dromaeojs", 22:58:37 INFO - "buildid": "20151115203128", 22:58:37 INFO - "slavename": "talos-linux64-ix-017", 22:58:37 INFO - "pgo_build": "True", 22:58:37 INFO - "basedir": "/builds/slave/test-pgo", 22:58:37 INFO - "project": "", 22:58:37 INFO - "platform": "ubuntu64_hw", 22:58:37 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 22:58:37 INFO - "slavebuilddir": "test", 22:58:37 INFO - "scheduler": "tests-b2g-inbound-linux64-pgo-talos", 22:58:37 INFO - "branch": "b2g-inbound", 22:58:37 INFO - "repo_path": "integration/b2g-inbound", 22:58:37 INFO - "stage_platform": "linux64-pgo", 22:58:37 INFO - "builduid": "3982465e336c4745823a36ee7ed01193", 22:58:37 INFO - "revision": "91245e9464943de25c76f2aacdca1b1976eabb87" 22:58:37 INFO - }, 22:58:37 INFO - "sourcestamp": { 22:58:37 INFO - "repository": "", 22:58:37 INFO - "hasPatch": false, 22:58:37 INFO - "project": "", 22:58:37 INFO - "branch": "b2g-inbound-linux64-pgo-talos", 22:58:37 INFO - "changes": [ 22:58:37 INFO - { 22:58:37 INFO - "category": null, 22:58:37 INFO - "files": [ 22:58:37 INFO - { 22:58:37 INFO - "url": null, 22:58:37 INFO - "name": "https://queue.taskcluster.net/v1/task/PAz6lGe7SA-GgW1my1TeGw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2" 22:58:37 INFO - } 22:58:37 INFO - ], 22:58:37 INFO - "repository": "", 22:58:37 INFO - "rev": "91245e9464943de25c76f2aacdca1b1976eabb87", 22:58:37 INFO - "who": "sendchange", 22:58:37 INFO - "when": 1447657079, 22:58:37 INFO - "number": 6665007, 22:58:37 INFO - "comments": "", 22:58:37 INFO - "project": "", 22:58:37 INFO - "at": "Sun 15 Nov 2015 22:57:59", 22:58:37 INFO - "branch": "b2g-inbound-linux64-pgo-talos", 22:58:37 INFO - "revlink": "", 22:58:37 INFO - "properties": [ 22:58:37 INFO - [ 22:58:37 INFO - "buildid", 22:58:37 INFO - "20151115203128", 22:58:37 INFO - "Change" 22:58:37 INFO - ], 22:58:37 INFO - [ 22:58:37 INFO - "builduid", 22:58:37 INFO - "3982465e336c4745823a36ee7ed01193", 22:58:37 INFO - "Change" 22:58:37 INFO - ], 22:58:37 INFO - [ 22:58:37 INFO - "pgo_build", 22:58:37 INFO - "True", 22:58:37 INFO - "Change" 22:58:37 INFO - ] 22:58:37 INFO - ], 22:58:37 INFO - "revision": "91245e9464943de25c76f2aacdca1b1976eabb87" 22:58:37 INFO - } 22:58:37 INFO - ], 22:58:37 INFO - "revision": "91245e9464943de25c76f2aacdca1b1976eabb87" 22:58:37 INFO - } 22:58:37 INFO - } 22:58:37 INFO - Found installer url https://queue.taskcluster.net/v1/task/PAz6lGe7SA-GgW1my1TeGw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2. 22:58:37 INFO - Running post-action listener: _resource_record_post_action 22:58:37 INFO - ##### 22:58:37 INFO - ##### Running download-and-extract step. 22:58:37 INFO - ##### 22:58:37 INFO - Running pre-action listener: _resource_record_pre_action 22:58:37 INFO - Running main action method: download_and_extract 22:58:37 INFO - mkdir: /builds/slave/test-pgo/build/tests 22:58:37 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')]} 22:58:37 INFO - https://queue.taskcluster.net/v1/task/PAz6lGe7SA-GgW1my1TeGw/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 22:58:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PAz6lGe7SA-GgW1my1TeGw/artifacts/public/build/test_packages.json 22:58:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PAz6lGe7SA-GgW1my1TeGw/artifacts/public/build/test_packages.json 22:58:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PAz6lGe7SA-GgW1my1TeGw/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 22:58:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PAz6lGe7SA-GgW1my1TeGw/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 22:58:38 INFO - Downloaded 1302 bytes. 22:58:38 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 22:58:38 INFO - Using the following test package requirements: 22:58:38 INFO - {u'common': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 22:58:38 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 22:58:38 INFO - u'firefox-45.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 22:58:38 INFO - u'jittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 22:58:38 INFO - u'jsshell-linux-x86_64.zip'], 22:58:38 INFO - u'mochitest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 22:58:38 INFO - u'firefox-45.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 22:58:38 INFO - u'mozbase': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 22:58:38 INFO - u'reftest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 22:58:38 INFO - u'firefox-45.0a1.en-US.linux-x86_64.reftest.tests.zip'], 22:58:38 INFO - u'talos': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 22:58:38 INFO - u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'], 22:58:38 INFO - u'web-platform': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 22:58:38 INFO - u'firefox-45.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 22:58:38 INFO - u'webapprt': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 22:58:38 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 22:58:38 INFO - u'firefox-45.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 22:58:38 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 22:58:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:58:38 INFO - https://queue.taskcluster.net/v1/task/PAz6lGe7SA-GgW1my1TeGw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 22:58:38 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PAz6lGe7SA-GgW1my1TeGw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 22:58:38 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PAz6lGe7SA-GgW1my1TeGw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 22:58:38 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PAz6lGe7SA-GgW1my1TeGw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 22:58:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PAz6lGe7SA-GgW1my1TeGw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 22:58:39 INFO - Downloaded 22461614 bytes. 22:58:39 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test-pgo/build/tests 22:58:39 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 22:58:39 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 22:58:41 INFO - Return code: 0 22:58:41 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 22:58:41 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')]} 22:58:41 INFO - https://queue.taskcluster.net/v1/task/PAz6lGe7SA-GgW1my1TeGw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 22:58:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PAz6lGe7SA-GgW1my1TeGw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 22:58:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PAz6lGe7SA-GgW1my1TeGw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 22:58:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PAz6lGe7SA-GgW1my1TeGw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 22:58:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PAz6lGe7SA-GgW1my1TeGw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 22:58:42 INFO - Downloaded 22461614 bytes. 22:58:42 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test-pgo/build/tests 22:58:42 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 22:58:42 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 22:58:43 INFO - Return code: 0 22:58:43 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')]} 22:58:43 INFO - https://queue.taskcluster.net/v1/task/PAz6lGe7SA-GgW1my1TeGw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 22:58:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PAz6lGe7SA-GgW1my1TeGw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 22:58:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PAz6lGe7SA-GgW1my1TeGw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 22:58:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PAz6lGe7SA-GgW1my1TeGw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 22:58:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PAz6lGe7SA-GgW1my1TeGw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 22:58:44 INFO - Downloaded 11131693 bytes. 22:58:44 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'] in /builds/slave/test-pgo/build/tests 22:58:44 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 22:58:44 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'] with output_timeout 1760 22:58:44 INFO - Return code: 0 22:58:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:58:44 INFO - https://queue.taskcluster.net/v1/task/PAz6lGe7SA-GgW1my1TeGw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 22:58:44 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PAz6lGe7SA-GgW1my1TeGw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 22:58:44 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PAz6lGe7SA-GgW1my1TeGw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 22:58:44 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PAz6lGe7SA-GgW1my1TeGw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 22:58:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PAz6lGe7SA-GgW1my1TeGw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 22:58:47 INFO - Downloaded 57145796 bytes. 22:58:47 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/PAz6lGe7SA-GgW1my1TeGw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 22:58:47 INFO - mkdir: /builds/slave/test-pgo/properties 22:58:47 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 22:58:47 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 22:58:47 INFO - Contents: 22:58:47 INFO - build_url:https://queue.taskcluster.net/v1/task/PAz6lGe7SA-GgW1my1TeGw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 22:58:47 INFO - Running post-action listener: _resource_record_post_action 22:58:47 INFO - Running post-action listener: set_extra_try_arguments 22:58:47 INFO - ##### 22:58:47 INFO - ##### Running populate-webroot step. 22:58:47 INFO - ##### 22:58:47 INFO - Running pre-action listener: _resource_record_pre_action 22:58:47 INFO - Running main action method: populate_webroot 22:58:47 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 22:58:47 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 22:58:47 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 22:58:47 INFO - '../fennec_ids.txt'], 22:58:47 INFO - 'tests': ['tcheck2']}, 22:58:47 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 22:58:47 INFO - '--tppagecycles', 22:58:47 INFO - '7'], 22:58:47 INFO - 'tests': ['tsvgm']}}, 22:58:47 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 22:58:47 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 22:58:47 INFO - 'tests': ['tresize', 'tcanvasmark']}, 22:58:47 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 22:58:47 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 22:58:47 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 22:58:47 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:58:47 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 22:58:47 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:58:47 INFO - 'talos_options': ['--e10s'], 22:58:47 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 22:58:47 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:58:47 INFO - 'tests': ['damp', 'tps']}, 22:58:47 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:58:47 INFO - 'talos_options': ['--e10s'], 22:58:47 INFO - 'tests': ['damp', 'tps']}, 22:58:47 INFO - 'g3': {'tests': ['dromaeo_dom']}, 22:58:47 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 22:58:47 INFO - 'other': {'tests': ['a11yr', 22:58:47 INFO - 'ts_paint', 22:58:47 INFO - 'tpaint', 22:58:47 INFO - 'sessionrestore', 22:58:47 INFO - 'sessionrestore_no_auto_restore']}, 22:58:47 INFO - 'other-e10s': {'talos_options': ['--e10s'], 22:58:47 INFO - 'tests': ['a11yr', 22:58:47 INFO - 'ts_paint', 22:58:47 INFO - 'tpaint', 22:58:47 INFO - 'sessionrestore', 22:58:47 INFO - 'sessionrestore_no_auto_restore']}, 22:58:47 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 22:58:47 INFO - 'tests': ['a11yr', 22:58:47 INFO - 'ts_paint', 22:58:47 INFO - 'tpaint', 22:58:47 INFO - 'sessionrestore', 22:58:47 INFO - 'sessionrestore_no_auto_restore']}, 22:58:47 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 22:58:47 INFO - 'tests': ['a11yr', 22:58:47 INFO - 'ts_paint', 22:58:47 INFO - 'tpaint', 22:58:47 INFO - 'sessionrestore', 22:58:47 INFO - 'sessionrestore_no_auto_restore']}, 22:58:47 INFO - 'other_l64': {'tests': ['a11yr', 22:58:47 INFO - 'ts_paint', 22:58:47 INFO - 'tpaint', 22:58:47 INFO - 'sessionrestore', 22:58:47 INFO - 'sessionrestore_no_auto_restore']}, 22:58:47 INFO - 'other_nol64': {'tests': ['a11yr', 22:58:47 INFO - 'ts_paint', 22:58:47 INFO - 'tpaint', 22:58:47 INFO - 'sessionrestore', 22:58:47 INFO - 'sessionrestore_no_auto_restore']}, 22:58:47 INFO - 'svgr': {'tests': ['tsvgx', 22:58:47 INFO - 'tsvgr_opacity', 22:58:47 INFO - 'tart', 22:58:47 INFO - 'tscrollx', 22:58:47 INFO - 'cart']}, 22:58:47 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 22:58:47 INFO - 'tests': ['tsvgx', 22:58:47 INFO - 'tsvgr_opacity', 22:58:47 INFO - 'tart', 22:58:47 INFO - 'tscrollx', 22:58:47 INFO - 'cart']}, 22:58:47 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:58:47 INFO - 'tests': ['tp5o']}, 22:58:47 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:58:47 INFO - 'talos_options': ['--e10s'], 22:58:47 INFO - 'tests': ['tp5o']}, 22:58:47 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:58:47 INFO - 'talos_options': ['--xperf_path', 22:58:47 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 22:58:47 INFO - 'tests': ['tp5n']}, 22:58:47 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:58:47 INFO - 'talos_options': ['--e10s', 22:58:47 INFO - '--xperf_path', 22:58:47 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 22:58:47 INFO - 'tests': ['tp5n']}}, 22:58:47 INFO - 'talos.zip': {'path': '', 22:58:47 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 22:58:47 INFO - Running post-action listener: _resource_record_post_action 22:58:47 INFO - ##### 22:58:47 INFO - ##### Running create-virtualenv step. 22:58:47 INFO - ##### 22:58:47 INFO - Running pre-action listener: _resource_record_pre_action 22:58:47 INFO - Running main action method: create_virtualenv 22:58:47 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 22:58:47 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test-pgo/build/venv'] in /builds/slave/test-pgo/build 22:58:47 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 22:58:47 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 22:58:47 INFO - Using real prefix '/usr' 22:58:47 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 22:58:48 INFO - Installing distribute.............................................................................................................................................................................................done. 22:58:50 INFO - Installing pip.................done. 22:58:50 INFO - Return code: 0 22:58:50 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 22:58: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')]} 22:58:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:58:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:58: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')]} 22:58:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:58:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:58:50 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--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 0x7f92031f2c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10566c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11173d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11a08c0>, '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 0x114d420>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x114d8b0>, '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': '6587686cb2da90a5f91b3170000001be-1447655857.723338-17557532', '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 22:58:50 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 22:58:50 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 22:58:50 INFO - Using env: {'DISPLAY': ':0', 22:58:50 INFO - 'HOME': '/home/cltbld', 22:58:50 INFO - 'LANG': 'en_US.UTF-8', 22:58:50 INFO - 'LANGUAGE': 'en_US:en', 22:58:50 INFO - 'LOGNAME': 'cltbld', 22:58:50 INFO - 'MAIL': '/var/mail/cltbld', 22:58:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:58:50 INFO - 'MOZ_NO_REMOTE': '1', 22:58:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:58:50 INFO - 'NO_EM_RESTART': '1', 22:58:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:58:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:58:50 INFO - 'PWD': '/builds/slave/test-pgo', 22:58:50 INFO - 'SHELL': '/bin/bash', 22:58:50 INFO - 'SHLVL': '1', 22:58:50 INFO - 'TERM': 'linux', 22:58:50 INFO - 'TMOUT': '86400', 22:58:50 INFO - 'USER': 'cltbld', 22:58:50 INFO - 'XDG_SESSION_COOKIE': '6587686cb2da90a5f91b3170000001be-1447655857.723338-17557532', 22:58:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:58:50 INFO - '_': '/tools/buildbot/bin/python'} 22:58:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:58:50 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 22:58:50 INFO - Cleaning up... 22:58:50 INFO - Return code: 0 22:58:50 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 22:58: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')]} 22:58:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:58:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:58: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')]} 22:58:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:58:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:58:50 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--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 0x7f92031f2c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10566c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11173d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11a08c0>, '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 0x114d420>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x114d8b0>, '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': '6587686cb2da90a5f91b3170000001be-1447655857.723338-17557532', '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 22:58:50 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 22:58:50 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 22:58:50 INFO - Using env: {'DISPLAY': ':0', 22:58:50 INFO - 'HOME': '/home/cltbld', 22:58:50 INFO - 'LANG': 'en_US.UTF-8', 22:58:50 INFO - 'LANGUAGE': 'en_US:en', 22:58:50 INFO - 'LOGNAME': 'cltbld', 22:58:50 INFO - 'MAIL': '/var/mail/cltbld', 22:58:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:58:50 INFO - 'MOZ_NO_REMOTE': '1', 22:58:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:58:50 INFO - 'NO_EM_RESTART': '1', 22:58:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:58:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:58:50 INFO - 'PWD': '/builds/slave/test-pgo', 22:58:50 INFO - 'SHELL': '/bin/bash', 22:58:50 INFO - 'SHLVL': '1', 22:58:50 INFO - 'TERM': 'linux', 22:58:50 INFO - 'TMOUT': '86400', 22:58:50 INFO - 'USER': 'cltbld', 22:58:50 INFO - 'XDG_SESSION_COOKIE': '6587686cb2da90a5f91b3170000001be-1447655857.723338-17557532', 22:58:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:58:50 INFO - '_': '/tools/buildbot/bin/python'} 22:58:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:58:50 INFO - Downloading/unpacking psutil>=0.7.1 22:58:50 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 22:58:50 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 22:58:50 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 22:58:50 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 22:58:50 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 22:58:50 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 22:58:52 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 22:58:52 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 22:58:52 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 22:58:52 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 22:58:52 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 22:58:52 INFO - Installing collected packages: psutil 22:58:52 INFO - Running setup.py install for psutil 22:58:52 INFO - building 'psutil._psutil_linux' extension 22:58:52 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 22:58:52 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 22:58:52 INFO - building 'psutil._psutil_posix' extension 22:58:52 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 22:58:52 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 22:58:52 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 22:58:52 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 22:58:52 INFO - Successfully installed psutil 22:58:52 INFO - Cleaning up... 22:58:53 INFO - Return code: 0 22:58:53 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 22:58: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')]} 22:58:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:58:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:58: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')]} 22:58:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:58:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:58:53 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 0x7f92031f2c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10566c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11173d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11a08c0>, '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 0x114d420>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x114d8b0>, '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': '6587686cb2da90a5f91b3170000001be-1447655857.723338-17557532', '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 22:58:53 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 22:58:53 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 22:58:53 INFO - Using env: {'DISPLAY': ':0', 22:58:53 INFO - 'HOME': '/home/cltbld', 22:58:53 INFO - 'LANG': 'en_US.UTF-8', 22:58:53 INFO - 'LANGUAGE': 'en_US:en', 22:58:53 INFO - 'LOGNAME': 'cltbld', 22:58:53 INFO - 'MAIL': '/var/mail/cltbld', 22:58:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:58:53 INFO - 'MOZ_NO_REMOTE': '1', 22:58:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:58:53 INFO - 'NO_EM_RESTART': '1', 22:58:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:58:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:58:53 INFO - 'PWD': '/builds/slave/test-pgo', 22:58:53 INFO - 'SHELL': '/bin/bash', 22:58:53 INFO - 'SHLVL': '1', 22:58:53 INFO - 'TERM': 'linux', 22:58:53 INFO - 'TMOUT': '86400', 22:58:53 INFO - 'USER': 'cltbld', 22:58:53 INFO - 'XDG_SESSION_COOKIE': '6587686cb2da90a5f91b3170000001be-1447655857.723338-17557532', 22:58:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:58:53 INFO - '_': '/tools/buildbot/bin/python'} 22:58:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:58:53 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 22:58:53 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 22:58:53 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 22:58:53 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 22:58:53 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 22:58:53 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 22:58:53 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 22:58:54 INFO - Downloading mozsystemmonitor-0.0.tar.gz 22:58:54 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 22:58:54 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 22:58:54 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 22:58:54 INFO - Installing collected packages: mozsystemmonitor 22:58:54 INFO - Running setup.py install for mozsystemmonitor 22:58:55 INFO - Successfully installed mozsystemmonitor 22:58:55 INFO - Cleaning up... 22:58:55 INFO - Return code: 0 22:58:55 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 22:58: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')]} 22:58:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:58:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:58: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')]} 22:58:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:58:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:58:55 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f92031f2c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10566c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11173d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11a08c0>, '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 0x114d420>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x114d8b0>, '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': '6587686cb2da90a5f91b3170000001be-1447655857.723338-17557532', '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 22:58:55 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test-pgo/build 22:58:55 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 22:58:55 INFO - Using env: {'DISPLAY': ':0', 22:58:55 INFO - 'HOME': '/home/cltbld', 22:58:55 INFO - 'LANG': 'en_US.UTF-8', 22:58:55 INFO - 'LANGUAGE': 'en_US:en', 22:58:55 INFO - 'LOGNAME': 'cltbld', 22:58:55 INFO - 'MAIL': '/var/mail/cltbld', 22:58:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:58:55 INFO - 'MOZ_NO_REMOTE': '1', 22:58:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:58:55 INFO - 'NO_EM_RESTART': '1', 22:58:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:58:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:58:55 INFO - 'PWD': '/builds/slave/test-pgo', 22:58:55 INFO - 'SHELL': '/bin/bash', 22:58:55 INFO - 'SHLVL': '1', 22:58:55 INFO - 'TERM': 'linux', 22:58:55 INFO - 'TMOUT': '86400', 22:58:55 INFO - 'USER': 'cltbld', 22:58:55 INFO - 'XDG_SESSION_COOKIE': '6587686cb2da90a5f91b3170000001be-1447655857.723338-17557532', 22:58:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:58:55 INFO - '_': '/tools/buildbot/bin/python'} 22:58:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:58:55 INFO - Downloading/unpacking blobuploader==1.2.4 22:58:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:58:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:58:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:58:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:58:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:58:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:58:57 INFO - Downloading blobuploader-1.2.4.tar.gz 22:58:57 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 22:58:57 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 22:58:57 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 22:58:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:58:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:58:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:58:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:58:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:58:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:58:57 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 22:58:57 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 22:58:57 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 22:58:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:58:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:58:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:58:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:58:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:58:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:58:57 INFO - Downloading docopt-0.6.1.tar.gz 22:58:57 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 22:58:57 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 22:58:57 INFO - Installing collected packages: blobuploader, requests, docopt 22:58:57 INFO - Running setup.py install for blobuploader 22:58:57 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 22:58:57 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 22:58:57 INFO - Running setup.py install for requests 22:58:58 INFO - Running setup.py install for docopt 22:58:58 INFO - Successfully installed blobuploader requests docopt 22:58:58 INFO - Cleaning up... 22:58:58 INFO - Return code: 0 22:58:58 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 22:58:58 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')]} 22:58:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:58:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:58:58 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')]} 22:58:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:58:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:58:58 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 0x7f92031f2c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10566c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11173d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11a08c0>, '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 0x114d420>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x114d8b0>, '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': '6587686cb2da90a5f91b3170000001be-1447655857.723338-17557532', '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 22:58:58 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 22:58:58 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 22:58:58 INFO - Using env: {'DISPLAY': ':0', 22:58:58 INFO - 'HOME': '/home/cltbld', 22:58:58 INFO - 'LANG': 'en_US.UTF-8', 22:58:58 INFO - 'LANGUAGE': 'en_US:en', 22:58:58 INFO - 'LOGNAME': 'cltbld', 22:58:58 INFO - 'MAIL': '/var/mail/cltbld', 22:58:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:58:58 INFO - 'MOZ_NO_REMOTE': '1', 22:58:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:58:58 INFO - 'NO_EM_RESTART': '1', 22:58:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:58:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:58:58 INFO - 'PWD': '/builds/slave/test-pgo', 22:58:58 INFO - 'SHELL': '/bin/bash', 22:58:58 INFO - 'SHLVL': '1', 22:58:58 INFO - 'TERM': 'linux', 22:58:58 INFO - 'TMOUT': '86400', 22:58:58 INFO - 'USER': 'cltbld', 22:58:58 INFO - 'XDG_SESSION_COOKIE': '6587686cb2da90a5f91b3170000001be-1447655857.723338-17557532', 22:58:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:58:58 INFO - '_': '/tools/buildbot/bin/python'} 22:58:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:58:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 22:58:58 INFO - Running setup.py (path:/tmp/pip-R1EXz1-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 22:58:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 22:58:58 INFO - Running setup.py (path:/tmp/pip-fd251d-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 22:58:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 22:58:58 INFO - Running setup.py (path:/tmp/pip-g85PB8-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 22:58:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 22:58:58 INFO - Running setup.py (path:/tmp/pip-wbv_3X-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 22:58:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 22:58:58 INFO - Running setup.py (path:/tmp/pip-CPtZrS-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 22:58:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 22:58:59 INFO - Running setup.py (path:/tmp/pip-VvO3S2-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 22:58:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 22:58:59 INFO - Running setup.py (path:/tmp/pip-Aao10C-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 22:58:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 22:58:59 INFO - Running setup.py (path:/tmp/pip-llqCDQ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 22:58:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 22:58:59 INFO - Running setup.py (path:/tmp/pip-atM_b5-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 22:58:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 22:58:59 INFO - Running setup.py (path:/tmp/pip-vTndL3-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 22:58:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 22:58:59 INFO - Running setup.py (path:/tmp/pip-Y9ERXo-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 22:58:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 22:58:59 INFO - Running setup.py (path:/tmp/pip-Ty43eA-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 22:58:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 22:58:59 INFO - Running setup.py (path:/tmp/pip-jZai_2-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 22:58:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 22:58:59 INFO - Running setup.py (path:/tmp/pip-BNwu0t-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 22:58:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 22:58:59 INFO - Running setup.py (path:/tmp/pip-hYnjm7-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 22:58:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 22:58:59 INFO - Running setup.py (path:/tmp/pip-EbAIAU-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 22:58:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 22:58:59 INFO - Running setup.py (path:/tmp/pip-xtpSvy-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 22:58:59 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 22:58:59 INFO - Running setup.py install for manifestparser 22:58:59 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 22:58:59 INFO - Running setup.py install for mozcrash 22:59:00 INFO - Running setup.py install for mozdebug 22:59:00 INFO - Running setup.py install for mozdevice 22:59:00 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 22:59:00 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 22:59:00 INFO - Running setup.py install for mozfile 22:59:00 INFO - Running setup.py install for mozhttpd 22:59:00 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 22:59:00 INFO - Running setup.py install for mozinfo 22:59:00 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 22:59:00 INFO - Running setup.py install for mozInstall 22:59:00 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 22:59:00 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 22:59:00 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 22:59:00 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 22:59:00 INFO - Running setup.py install for mozleak 22:59:00 INFO - Running setup.py install for mozlog 22:59:00 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 22:59:00 INFO - Running setup.py install for moznetwork 22:59:00 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 22:59:00 INFO - Running setup.py install for mozprocess 22:59:01 INFO - Running setup.py install for mozprofile 22:59:01 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 22:59:01 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 22:59:01 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 22:59:01 INFO - Running setup.py install for mozrunner 22:59:01 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 22:59:01 INFO - Running setup.py install for mozscreenshot 22:59:01 INFO - Running setup.py install for moztest 22:59:01 INFO - Running setup.py install for mozversion 22:59:01 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 22:59:01 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 22:59:01 INFO - Cleaning up... 22:59:01 INFO - Return code: 0 22:59:01 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 22:59: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')]} 22:59:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:59:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:59: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')]} 22:59:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:59:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:59: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', '-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 0x7f92031f2c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10566c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11173d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11a08c0>, '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 0x114d420>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x114d8b0>, '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': '6587686cb2da90a5f91b3170000001be-1447655857.723338-17557532', '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 22:59:01 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 22:59:01 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 22:59:01 INFO - Using env: {'DISPLAY': ':0', 22:59:01 INFO - 'HOME': '/home/cltbld', 22:59:01 INFO - 'LANG': 'en_US.UTF-8', 22:59:01 INFO - 'LANGUAGE': 'en_US:en', 22:59:01 INFO - 'LOGNAME': 'cltbld', 22:59:01 INFO - 'MAIL': '/var/mail/cltbld', 22:59:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:59:01 INFO - 'MOZ_NO_REMOTE': '1', 22:59:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:59:01 INFO - 'NO_EM_RESTART': '1', 22:59:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:59:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:59:01 INFO - 'PWD': '/builds/slave/test-pgo', 22:59:01 INFO - 'SHELL': '/bin/bash', 22:59:01 INFO - 'SHLVL': '1', 22:59:01 INFO - 'TERM': 'linux', 22:59:01 INFO - 'TMOUT': '86400', 22:59:01 INFO - 'USER': 'cltbld', 22:59:01 INFO - 'XDG_SESSION_COOKIE': '6587686cb2da90a5f91b3170000001be-1447655857.723338-17557532', 22:59:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:59:01 INFO - '_': '/tools/buildbot/bin/python'} 22:59:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:59:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 22:59:01 INFO - Running setup.py (path:/tmp/pip-osYcJ1-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 22:59:01 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)) 22:59:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 22:59:01 INFO - Running setup.py (path:/tmp/pip-coNUZw-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 22:59:02 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)) 22:59:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 22:59:02 INFO - Running setup.py (path:/tmp/pip-X8_Hdl-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 22:59:02 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)) 22:59:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 22:59:02 INFO - Running setup.py (path:/tmp/pip-OByldx-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 22:59:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.47 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)) 22:59:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 22:59:02 INFO - Running setup.py (path:/tmp/pip-IQz_UR-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 22:59:02 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)) 22:59:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 22:59:02 INFO - Running setup.py (path:/tmp/pip-fSEAA2-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 22:59:02 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)) 22:59:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 22:59:02 INFO - Running setup.py (path:/tmp/pip-4q9o7y-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 22:59:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 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)) 22:59:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 22:59:02 INFO - Running setup.py (path:/tmp/pip-lhhkpt-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 22:59:02 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)) 22:59:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 22:59:02 INFO - Running setup.py (path:/tmp/pip-1zGXRI-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 22:59:02 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)) 22:59:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 22:59:02 INFO - Running setup.py (path:/tmp/pip-oZVL1p-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 22:59:02 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)) 22:59:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 22:59:02 INFO - Running setup.py (path:/tmp/pip-u8wApI-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 22:59:02 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)) 22:59:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 22:59:02 INFO - Running setup.py (path:/tmp/pip-Of2I4x-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 22:59:02 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)) 22:59:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 22:59:02 INFO - Running setup.py (path:/tmp/pip-LDfI9c-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 22:59:02 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)) 22:59:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 22:59:02 INFO - Running setup.py (path:/tmp/pip-lwOTss-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 22:59:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 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)) 22:59:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 22:59:02 INFO - Running setup.py (path:/tmp/pip-VPUx0e-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 22:59:02 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)) 22:59:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 22:59:02 INFO - Running setup.py (path:/tmp/pip-w4XK1a-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 22:59:03 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)) 22:59:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 22:59:03 INFO - Running setup.py (path:/tmp/pip-3voKGZ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 22:59:03 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)) 22:59:03 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)) 22:59:03 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)) 22:59:03 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)) 22:59:03 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.47->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 22:59:03 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.47->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 22:59:03 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.0->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 22:59:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:59:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:59:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:59:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:59:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:59:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:59:04 INFO - Downloading blessings-1.5.1.tar.gz 22:59:04 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 22:59:04 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 22:59:04 INFO - Installing collected packages: blessings 22:59:04 INFO - Running setup.py install for blessings 22:59:04 INFO - Successfully installed blessings 22:59:04 INFO - Cleaning up... 22:59:04 INFO - Return code: 0 22:59:04 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 22:59:04 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 22:59:04 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 22:59:05 INFO - Reading from file tmpfile_stdout 22:59:05 INFO - Current package versions: 22:59:05 INFO - argparse == 1.2.1 22:59:05 INFO - blessings == 1.5.1 22:59:05 INFO - blobuploader == 1.2.4 22:59:05 INFO - docopt == 0.6.1 22:59:05 INFO - manifestparser == 1.1 22:59:05 INFO - mozInstall == 1.12 22:59:05 INFO - mozcrash == 0.16 22:59:05 INFO - mozdebug == 0.1 22:59:05 INFO - mozdevice == 0.47 22:59:05 INFO - mozfile == 1.2 22:59:05 INFO - mozhttpd == 0.7 22:59:05 INFO - mozinfo == 0.9 22:59:05 INFO - mozleak == 0.1 22:59:05 INFO - mozlog == 3.0 22:59:05 INFO - moznetwork == 0.27 22:59:05 INFO - mozprocess == 0.22 22:59:05 INFO - mozprofile == 0.27 22:59:05 INFO - mozrunner == 6.11 22:59:05 INFO - mozscreenshot == 0.1 22:59:05 INFO - mozsystemmonitor == 0.0 22:59:05 INFO - moztest == 0.7 22:59:05 INFO - mozversion == 1.4 22:59:05 INFO - psutil == 3.1.1 22:59:05 INFO - requests == 1.2.3 22:59:05 INFO - wsgiref == 0.1.2 22:59:05 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 22:59: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')]} 22:59:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:59:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:59: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')]} 22:59:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:59:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:59: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', '-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 0x7f92031f2c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10566c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11173d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11a08c0>, '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 0x114d420>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x114d8b0>, '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': '6587686cb2da90a5f91b3170000001be-1447655857.723338-17557532', '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 22:59:05 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 22:59:05 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 22:59:05 INFO - Using env: {'DISPLAY': ':0', 22:59:05 INFO - 'HOME': '/home/cltbld', 22:59:05 INFO - 'LANG': 'en_US.UTF-8', 22:59:05 INFO - 'LANGUAGE': 'en_US:en', 22:59:05 INFO - 'LOGNAME': 'cltbld', 22:59:05 INFO - 'MAIL': '/var/mail/cltbld', 22:59:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:59:05 INFO - 'MOZ_NO_REMOTE': '1', 22:59:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:59:05 INFO - 'NO_EM_RESTART': '1', 22:59:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:59:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:59:05 INFO - 'PWD': '/builds/slave/test-pgo', 22:59:05 INFO - 'SHELL': '/bin/bash', 22:59:05 INFO - 'SHLVL': '1', 22:59:05 INFO - 'TERM': 'linux', 22:59:05 INFO - 'TMOUT': '86400', 22:59:05 INFO - 'USER': 'cltbld', 22:59:05 INFO - 'XDG_SESSION_COOKIE': '6587686cb2da90a5f91b3170000001be-1447655857.723338-17557532', 22:59:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:59:05 INFO - '_': '/tools/buildbot/bin/python'} 22:59:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:59:05 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)) 22:59:05 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)) 22:59:05 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)) 22:59:05 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)) 22:59:05 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)) 22:59:05 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)) 22:59:05 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)) 22:59:05 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)) 22:59:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash>=0.15->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 22:59:05 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 3)) 22:59:05 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)) 22:59:05 INFO - Cleaning up... 22:59:05 INFO - Return code: 0 22:59:05 INFO - Running post-action listener: _resource_record_post_action 22:59:05 INFO - Running post-action listener: _start_resource_monitoring 22:59:05 INFO - Starting resource monitoring. 22:59:05 INFO - ##### 22:59:05 INFO - ##### Running install step. 22:59:05 INFO - ##### 22:59:05 INFO - Running pre-action listener: _resource_record_pre_action 22:59:05 INFO - Running main action method: install 22:59:05 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 22:59:05 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 22:59:05 INFO - Reading from file tmpfile_stdout 22:59:05 INFO - Detecting whether we're running mozinstall >=1.0... 22:59:05 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 22:59:05 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 22:59:05 INFO - Reading from file tmpfile_stdout 22:59:05 INFO - Output received: 22:59:05 INFO - Usage: mozinstall [options] installer 22:59:05 INFO - Options: 22:59:05 INFO - -h, --help show this help message and exit 22:59:05 INFO - -d DEST, --destination=DEST 22:59:05 INFO - Directory to install application into. [default: 22:59:05 INFO - "/builds/slave/test-pgo"] 22:59:05 INFO - --app=APP Application being installed. [default: firefox] 22:59:05 INFO - mkdir: /builds/slave/test-pgo/build/application 22:59:05 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test-pgo/build/application'] 22:59:05 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test-pgo/build/application 22:59:20 INFO - Reading from file tmpfile_stdout 22:59:20 INFO - Output received: 22:59:20 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 22:59:20 INFO - Running post-action listener: _resource_record_post_action 22:59:20 INFO - ##### 22:59:20 INFO - ##### Running run-tests step. 22:59:20 INFO - ##### 22:59:20 INFO - Running pre-action listener: _resource_record_pre_action 22:59:20 INFO - Running main action method: run_tests 22:59:20 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 22:59:20 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 22:59:20 INFO - Python 2.7.3 22:59:20 INFO - Return code: 0 22:59:20 INFO - grabbing minidump binary from tooltool 22:59:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:59:20 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 0x11a08c0>, '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 0x114d420>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x114d8b0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 22:59:20 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 22:59:20 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 22:59:20 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 22:59:20 INFO - Return code: 0 22:59:20 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 22:59:20 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 22:59:20 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 22:59:20 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 22:59:20 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 22:59:20 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'B2G-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/PAz6lGe7SA-GgW1my1TeGw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-017', '--webServer', 'localhost'] in /builds/slave/test-pgo/build 22:59:20 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --debug --branchName B2G-Inbound --suite dromaeojs --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/PAz6lGe7SA-GgW1my1TeGw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-017 --webServer localhost 22:59:20 INFO - Using env: {'DISPLAY': ':0', 22:59:20 INFO - 'HOME': '/home/cltbld', 22:59:20 INFO - 'LANG': 'en_US.UTF-8', 22:59:20 INFO - 'LANGUAGE': 'en_US:en', 22:59:20 INFO - 'LOGNAME': 'cltbld', 22:59:20 INFO - 'MAIL': '/var/mail/cltbld', 22:59:20 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 22:59:20 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 22:59:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:59:20 INFO - 'MOZ_NO_REMOTE': '1', 22:59:20 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 22:59:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:59:20 INFO - 'NO_EM_RESTART': '1', 22:59:20 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:59:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:59:20 INFO - 'PWD': '/builds/slave/test-pgo', 22:59:20 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 22:59:20 INFO - 'SHELL': '/bin/bash', 22:59:20 INFO - 'SHLVL': '1', 22:59:20 INFO - 'TERM': 'linux', 22:59:20 INFO - 'TMOUT': '86400', 22:59:20 INFO - 'USER': 'cltbld', 22:59:20 INFO - 'XDG_SESSION_COOKIE': '6587686cb2da90a5f91b3170000001be-1447655857.723338-17557532', 22:59:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:59:20 INFO - '_': '/tools/buildbot/bin/python'} 22:59:20 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'B2G-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/PAz6lGe7SA-GgW1my1TeGw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-017', '--webServer', 'localhost'] with output_timeout 3600 22:59:20 INFO - mozversion INFO | application_buildid: 20151115203128 22:59:20 INFO - mozversion INFO | application_changeset: 91245e9464943de25c76f2aacdca1b1976eabb87 22:59:20 INFO - mozversion INFO | application_display_name: Nightly 22:59:20 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 22:59:20 INFO - mozversion INFO | application_name: Firefox 22:59:20 INFO - mozversion INFO | application_remotingname: firefox 22:59:20 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/b2g-inbound 22:59:20 INFO - mozversion INFO | application_vendor: Mozilla 22:59:20 INFO - mozversion INFO | application_version: 45.0a1 22:59:20 INFO - mozversion INFO | platform_buildid: 20151115203128 22:59:20 INFO - mozversion INFO | platform_changeset: 91245e9464943de25c76f2aacdca1b1976eabb87 22:59:20 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/b2g-inbound 22:59:20 INFO - mozversion INFO | platform_version: 45.0a1 22:59:20 INFO - 2015-11-15 22:59:20,555 DEBUG : using testdate: 1447657160 22:59:20 INFO - 2015-11-15 22:59:20,555 DEBUG : actual date: 1447657160 22:59:20 INFO - 2015-11-15 22:59:20,563 INFO : starting webserver on 'localhost:37965' 22:59:20 INFO - 2015-11-15 22:59:20,564 INFO : Starting test suite talos-linux64-ix-017 22:59:20 INFO - 2015-11-15 22:59:20,564 INFO : Starting test dromaeo_css 22:59:20 INFO - 2015-11-15 22:59:20,564 DEBUG : operating with platform_type : linux_ 22:59:20 INFO - 2015-11-15 22:59:20,565 INFO : Initialising browser for dromaeo_css test... 22:59:20 INFO - 2015-11-15 22:59:20,579 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpL44yNl/profile http://localhost:37965/getInfo.html 22:59:24 INFO - 2015-11-15 22:59:24,350 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 22:59:24 INFO - 2015-11-15 22:59:24,351 DEBUG : BROWSER_OUTPUT: colorDepth:24 22:59:24 INFO - 2015-11-15 22:59:24,351 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 22:59:24 INFO - 2015-11-15 22:59:24,351 DEBUG : BROWSER_OUTPUT: __metrics 22:59:24 INFO - 2015-11-15 22:59:24,467 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 22:59:25 INFO - 2015-11-15 22:59:25,449 INFO : Browser initialized. 22:59:25 INFO - 2015-11-15 22:59:25,450 INFO : Running cycle 1/1 for dromaeo_css test... 22:59:25 INFO - 2015-11-15 22:59:25,450 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpL44yNl/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 22:59:37 INFO - 2015-11-15 22:59:37,212 DEBUG : BROWSER_OUTPUT: RSS: Main: 141651968 22:59:37 INFO - 2015-11-15 22:59:37,212 DEBUG : BROWSER_OUTPUT: 23:00:28 INFO - 2015-11-15 23:00:28,794 DEBUG : BROWSER_OUTPUT: 1447657228790 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 23:02:37 INFO - 2015-11-15 23:02:37,182 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37965/tests/dromaeo/cssquery-dojo.html (next: http://localhost:37965/tests/dromaeo/cssquery-ext.html) 23:02:38 INFO - 2015-11-15 23:02:38,239 DEBUG : BROWSER_OUTPUT: RSS: Main: 226660352 23:02:38 INFO - 2015-11-15 23:02:38,239 DEBUG : BROWSER_OUTPUT: 23:05:40 INFO - 2015-11-15 23:05:40,654 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37965/tests/dromaeo/cssquery-ext.html (next: http://localhost:37965/tests/dromaeo/cssquery-jquery.html) 23:05:41 INFO - 2015-11-15 23:05:41,220 DEBUG : BROWSER_OUTPUT: RSS: Main: 224145408 23:05:41 INFO - 2015-11-15 23:05:41,220 DEBUG : BROWSER_OUTPUT: 23:08:43 INFO - 2015-11-15 23:08:43,148 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37965/tests/dromaeo/cssquery-jquery.html (next: http://localhost:37965/tests/dromaeo/cssquery-mootools.html) 23:08:43 INFO - 2015-11-15 23:08:43,721 DEBUG : BROWSER_OUTPUT: RSS: Main: 219906048 23:08:43 INFO - 2015-11-15 23:08:43,722 DEBUG : BROWSER_OUTPUT: 23:11:45 INFO - 2015-11-15 23:11:45,614 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37965/tests/dromaeo/cssquery-mootools.html (next: http://localhost:37965/tests/dromaeo/cssquery-prototype.html) 23:11:46 INFO - 2015-11-15 23:11:46,175 DEBUG : BROWSER_OUTPUT: RSS: Main: 202612736 23:11:46 INFO - 2015-11-15 23:11:46,175 DEBUG : BROWSER_OUTPUT: 23:14:48 INFO - 2015-11-15 23:14:48,662 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37965/tests/dromaeo/cssquery-prototype.html (next: http://localhost:37965/tests/dromaeo/cssquery-yui.html) 23:14:49 INFO - 2015-11-15 23:14:49,223 DEBUG : BROWSER_OUTPUT: RSS: Main: 207732736 23:14:49 INFO - 2015-11-15 23:14:49,223 DEBUG : BROWSER_OUTPUT: 23:17:51 INFO - 2015-11-15 23:17:51,484 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37965/tests/dromaeo/cssquery-yui.html (next: http://localhost:37965/tests/dromaeo/cssquery-dojo.html) 23:17:51 INFO - 2015-11-15 23:17:51,730 DEBUG : BROWSER_OUTPUT: RSS: Main: 259649536 23:17:51 INFO - 2015-11-15 23:17:51,731 DEBUG : BROWSER_OUTPUT: 23:17:51 INFO - 2015-11-15 23:17:51,731 DEBUG : BROWSER_OUTPUT: __start_tp_report 23:17:51 INFO - 2015-11-15 23:17:51,731 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 23:17:51 INFO - 2015-11-15 23:17:51,731 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 23:17:51 INFO - 2015-11-15 23:17:51,731 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 23:17:51 INFO - 2015-11-15 23:17:51,735 DEBUG : BROWSER_OUTPUT: |0;dojo.html;3155.4320222359975;3219.7424206063515;3262.8694852205913;3265.5754751882237;3296.4231259529574;5222;5299.417064122943;5369.409364969855;5430.83707488775;5462.972685136574;5363.758630861611;5369.650972686783;5417.404085550586;5428.050091234038;5509.944900550993;4960.6775559588605;5044.82343117991;5069.2649565812935;5073.847784566469;5096.413912400084;4819.638527110481;5030.723310217936;5059.089363914494;5128.000039992203;5134.0245353382925;4806.783694733728;4916.50834916509;4938.654294199408;4954.7274899880495;4974.77613507393;4930.433000204951;4944.35723355965;4948.87627809304;4960.553550180501;4994.900101997976;4868.9269660955115;4939.962607852355;4940.55535001848;4941.851744447672;4994.950050499485;5201.973990130063;5270.947290527084;5302.761375738101;5327.147656375;5339.599530035224;5840.445157710011;5863.208466856962;5872.060470324727;5872.324682661463;5872.412758724136;5799.88400231993;5894.734736936805;5906.5570082244;5914.467697907209;5915.290165180163;5447.046766815831;5490.780368785204;5495.53287970523;5504.2294078829;5549.667019978774;5904.232449781587;5919.141724450017;5925.792597259076;5946.464818166386;5976.462118409364;5614.157876318585;5740.196372507852;5749.195112684228;5760.481556659921;5783.161441590946;5830.38780928005;5926.229590153339;5937.7921772737745;5945.702714864239;5994.430529099728;5750.741216645261;5765.509931655856;5767.077267637158;5769.509591684669;5786.566007549451;5613.073842815971;5745.368009518949;5754.4533269339345;5764.279465066867;5790.739416726257;4509.616682582017;4521.276595744665;4525.954740452619;4540.614047805908;4563.224251877189;3981.8407263709128;3986.5415477219913;4024.63778259958;4025.134596061861;4031.637152656216;5379.811706590251;5480.369757477862;5487.204355368449;5589.049861523551;5658.122990936411;5839.240898683229;5864.296284445893;5866.823995280149;5867;5871.32479764824;5541.168824676251;5554.389017208104;5554.91667624986;5556.388797232301;5560.026995275811;4976.950230497721;5068.189089745623;5068.493150684976;5144.9742751286;5164.664296820694;6127.417895300028;6140.263168419819;6164.229471316085;6166.660833654102;6169.198004259418;5666.801661941977;5929.703514824155;5930.347661757117;5930.703464826827;5931.406859314034;5932.673702946379;5988.341282459013;5999.610025348338;6033;6051.031834906394;5836.095405212199;5849.298084229919;5854.677992710442;5861.794837180678;5894.2926848778425;5649.858753531194;5779.36426993022;5923.348431672599;5927.792527261525;5931.08068249422;5651.180578816131;5759.683217422914;5798.072308430631;5798.507126894093;5801.129830525455;5734.5125664319;5734.684592347294;5737.483626473638;5740.39725828782;5742.224799651994;5582.302212223472;5654.6324488908085;5655.830325090254;5656.632318899258;5658.745356459051;5558;5660.349059858169;5665.915011274752;5702.287214098238;5705.771769129188;5546.278983732089;5728.656280623176;5728.942710573007;5735.512481438957;5765.336986246468 23:17:51 INFO - 2015-11-15 23:17:51,735 DEBUG : BROWSER_OUTPUT: |1;ext.html;571.0634559322709;580.465971306398;608.7747533412638;612.1216054961131;616.8457885528618;30723.38553228937;39077.4138387924;39864.40203396951;39915;40155.59844401555;42203.57796422035;43061.7846910765;43089;43091.78454107733;43157.568424315745;7622.047244094489;7759.1852855450215;8716.912830871705;8893.68872089477;8897.377183597151;10213.48932553373;10368.170546356274;10404.843927341059;10416.27086103973;10448.63429779958;10069.64756233532;10086.949565252164;10146.086852183302;10160.136388406994;10163.796724065514;7826;8001.95999020007;10088.74778130549;10507.632232871812;10820.513076911559;10244.28290019699;10386.11718003963;10410.219233557438;10447.164226861833;10451.581936722521;39525.628462292065;39872;40040.59959400398;40043.7997810012;40094.59905400938;3172.6034245719284;3240.983795081033;3445.9655403445895;3888.241792850395;3908.4137379393032;29595.260118496994;30002;30259.243518911982;31007.379852402824;31019.379612407625;3437.74216933731;3443.8450269737673;3500.9474857877153;3546.414841551141;3604.1530240393486;270447;271134;271450;271475;271660;54887.45112548903;55983.44016559864;57118;58081;58284.54288642733;52310.47689523056;52376;52710.47289527133;52719.472805271456;52736.20895686568;13298.933505332412;13528.39122239482;13565.864341356657;13568.864311356958;13574.660633484242;9659.806803864023;9718.222542196607;9853.261005424622;9884.258680598983;9898.257630677728;18910.338138165098;18945.90527047356;19042;19125.23499060022;19125.808741912402;6843.931560684329;7136;7197.352238298578;7225.060742103493;7235.963820180866;925.7685578605349;999.160705007797;1029.444100185906;1072.8337107748312;1073.4418102586612;27239.591406128922;27987.86006069997;28069;28496.430071398456;28951.7104828949;1023.6366090038078;1027.2963020331097;1044.5395230499385;1093.1637297467444;1107.7673688525338;14063.648408789863;14164.22096784666;14222.359993800304;14252.643683907778;14397.928010359881;311802;316409;316426;316663;317089;43120.784396078445;48971.755141224065;49787.25319120216;49822.75088624606;50096.49903500991;1280.2766436963086;1305.902057345684;1306.0139594606012;1309.5285697149018;1310.8099325597734;25179.118730844333;25297.241082767545;25716.61425078588;25800.483990320463;25916;42111.157776844906;43164.352534711375;48016.519834801205;49273.50726492689;49293.50706493032;257748;258924;258976;260766;260787;31209.219769505944;31585.5262171063;31651.36697266088;31699.84150079327;31700.524492132176;40097.799511003424;40507.1898562033;41205.38191927184;41216.79391603143;41345.79327103345;34673.47989780105;34971.47542786809;35231;35561.466578000836;35676;34811.47782783311;35141.64858351486;35238;35404.822975884956;35546.64453355433;34898.82550587231;35226.823865880506;35477.467837982964;36051.098722532144;36143.81928090343;27605.309867252676;29127.7087229125;30522.236944076576;31392.68607313989;31561.36877262488;24405.877970610032;24486.26541203767;24526.63210051815;24707;24733.381665458506 23:17:51 INFO - 2015-11-15 23:17:51,738 DEBUG : BROWSER_OUTPUT: |2;jquery.html;350.83160083160084;352.08809184212885;352.53289391556194;353.1630036812753;353.57041194948135;13787.931060344685;14163.575092747235;16554;16797;17468.47594572163;15808.920955395235;15839.445619403323;15844;15911.28399222035;15971.361145554163;5119.206522988924;5366.248725178459;5369.731513424333;5374.596905232103;5380.408155102936;3955.2880481513316;4086.3870419437026;5278.023565640369;5835.5915085944;5989.311229208632;5901.085331773582;5918.319393269764;5921.230240068785;5947.910781338283;5948;5835.912461313083;6013.128096425994;6015.428534289235;6021.42796434338;6028.276606807167;5170.741462926876;5234.136367499358;5265.631405801557;5267.1835865440535;5268.525832675077;19755.308564200182;19998.500037499034;20099.196032158696;20151.899240503702;20255.392338229878;2056.7223424837607;2137.6900349449243;2213.944651383712;2271;2691.8384896906055;12552.8117078243;12915.095943283974;12931.159474634118;12953.740925181537;12983.415746291439;1679.971818547159;1759.9912000439915;1819.46325833878;1827.6801559726994;1884.293389978758;58721;59305.110423343685;59414.40585594175;60111.398886011455;60632;9445.527723613792;9565.186959108554;9691.563879625433;9736.75658108553;9813.754656133653;12481.56314528987;12486.376771019892;12579.11946163778;12593.37033148339;12600.11799174049;6996.510244282953;7063.5761854287875;7073.575585464889;7085.291470852977;7093.290670932865;6665.900011499832;6737.326267373223;6737.730490780412;6744.393004629607;6879.6560171992205;5692.345380281321;5810.157527158538;5813.244278243801;5833.591648584643;5854.151148083504;1605.3658804772049;1641.9917900410421;1646.9011859288241;1650.4058538925976;1675.7067513185143;875.3216257400566;876.8465518534231;908.14180599333;919.2186641354929;940.557937769261;14156.787648185285;16344;16512.42206522766;16833.158342082847;16956.830431695773;473.07985967293973;481.6556162343941;945.2154711589365;996.1582462818907;1024.144839059379;6265.122882796412;6474.611523308617;6548.264709851893;6552.57408268461;6556.672166391757;536409;550169;558880;559975;560329;76379;78939.21060789433;79164.6041769799;80620;82142.17857821465;552.9612927095145;566.1875209074908;566.5411017076182;566.9149627555818;567.4042255631571;10527.105196058421;10988.890111098786;11084.722881928017;11099.556017759522;11208.383538905438;34765.82617086898;35128;35485.46771798374;36241.27517449584;36637.63362366342;46299;46892.29661555147;48270;48660.75669621771;48759.26861097015;6788.558743681645;6876.037354770237;6878.58728476293;6898.517103802887;6903.413209877016;10043.347182433119;10306.948465257627;12066.818997714865;12148.878511214774;12210.511579536718;10185.08334249921;10384.948075259575;10451.059404653617;10517.474126293502;10587.947060264958;9828.606855725977;10071.143952764098;10118.8482172766;10293.176545876462;10450.477476126316;10341.224408169266;10521;10536;10581.36511809294;10678.89321106779;6689.331066893272;6709.396154346132;6816.931830681629;6817.7272909083085;6826.112605361272;10610.098141658045;10678.786424271626;10811.243212975016;10833.29583577065;11052.668419947415 23:17:51 INFO - 2015-11-15 23:17:51,739 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1300.3823183987602;1667.441407128612;1693.2549678141609;1695.279506209861;1726.3612463388545;6656.134702488675;7089.822754431142;7203.639818009105;7214.675339609717;7222.638868056602;7275.417966562675;7368.447366447511;7381.188069312371;7389.2241314662;7398.593077380742;1934.139308007937;1964.2830366916044;2158.7949144831255;2177.858439201455;2183.410479170623;2217.800397964183;2229.8550594211406;2230.7992280694734;2233.196049422215;2233.3188377544843;2128.1168315149193;2237.5301186750803;2239.8096161826184;2240.831937604686;2242.6187548116777;1878.6242751449697;1916.9041547922548;2177.934661960144;2208.9116435342726;2228.7882651148116;2236.630955892276;2248.5278091600785;2276.362618466832;2281.167373908528;2283.1095872609694;7494.6627401767055;7551.131619863731;7561.395088392916;7573.848523029564;7593.544387336778;4474.2841145416905;4524.8416305429155;4548.135854187727;4550.226461501553;4550.453945526525;2902.4485347783852;2963.659179194399;2987.3129180288656;2999.43010827942;3000.3999200159838;980.3039841712392;984.6110786239395;990.8810942686923;1016.044917777287;1038.3717850700293;10428.165746740318;10461.581536738522;10464.215183861164;10470.162387009097;10481.056704896597;3960.128771670228;3989.860354887565;4006.138680183716;4191.601797829201;4238.724482908663;8950.597223124974;8975.551222438851;8990.955045224731;8994.685186018458;9010.053944335881;4316.395704601358;4321.58944900234;4324.372965919924;4325.935110973338;4330.848420305274;3948.1116748731306;3948.861789837342;3950.051987523031;3957.722959392815;3958.5051868516434;3624.311380837685;3658.8536458541894;3663.780173189617;3672.7245456590863;3705.481232627434;1149.896509314149;1153.1870031627682;1153.7173392518719;1161.3206274329443;1163.3775929877474;966.7438128895848;1211.3337664284609;1218.9878101218874;1222.7860124478182;1243.9502419903104;6415.358464153547;6778.525503214826;7072.646367681698;7074.398676112588;7074.858502829915;615.1725928625991;620.5501011766434;625.8810825943057;670.8289386206486;677.5325025732327;5208.270842082112;5277.234800953917;5313.946860531422;5486.067368547357;5489.204065410493;8554.27288680469;8642.481451112953;8701.042885282613;8724.476531408136;8727.956360218159;8531.189536993976;8609;8653.307735381155;8852.955735221283;8883.689070882489;6843.828904277333;6888.173419189629;6896.689648965808;6929.688164032631;6949.895751563629;6504.837379065561;6622.8344291393105;6633.1045308882685;6636.535442519171;6673.9332606673315;7689;7841.921580784119;7868.72459463916;7878.881816772639;7942.12636609984;7939.325157361689;7985.441019128838;8055.3152981994845;8078.515289082438;8110.270075693216;6424.743010279723;6436.292007879223;6443.259025212161;6461.418472337512;6469;7080;7092.716291348494;7163.820904477429;7174.3184397482155;7176.031235783311;6779.118714567075;6812.965935170292;6882.070920425678;6964.686589103604;7163.8567228656175;6965.895511567229;6976.860462790817;7016.403605693573;7022.789316320519;7113.466490013167;6131.693415329305;6209.130721699056;7032.648367581703;7055.435565154878;7064.046353742385;6265.342139075331;6318.368163183829;6329.050642403677;6368.172137622079;6413.262474815456;6297.118403423616;6343.365663433619;6346.682665866781;6351.396617321347;6352.555321127476 23:17:51 INFO - 2015-11-15 23:17:51,740 DEBUG : BROWSER_OUTPUT: |4;prototype.html;331.07299561228564;331.65010913486265;338.71040260577206;341.6515154542367;343.2774010707459;5986.700664966751;6027.457528822405;6058.787942422016;6075.149479072922;6082.665453400066;5705.857353566163;5835.978703726842;5875.7062146892695;5942;6007.068904319837;4582.587567118959;4595.839145629912;4607.262837945929;4614.953850461503;4620.260758278676;4393.824247030131;4595.126925884088;4608.953910460886;4614.446266448031;4617.422822147231;4418.447694038246;4446.333050042504;4468.530804265554;4497.640188784906;4515.61617262533;4449.688521803475;4490.50604433512;4491.23648979671;4501.774911254457;4511.52628973958;3999.600039996006;4002.1595464952393;4003.739756915791;4004;4007.4189242559955;5534.05920993428;5646.378898321182;5652.943470565283;5654.491095801398;5659.377468478464;5307.230451584537;5311.495407936279;5318.920216196721;5319.707416092114;5325.946740532584;6282.560220784547;6299.5905266158015;6308.369163083701;6312.053192021188;6316.431521163071;4411.558844115562;4416.116776644684;4419.270820314644;4432.401625780542;4433.091216300651;6422.165118534607;6560.868782624369;6584.93415065848;6590.703418346186;6596.703148358335;4520.4575450946095;4524.796384162721;4538.092381523708;4540.182767101887;4547.522510136454;4562.908741825211;4567;4568.88577785558;4569.680122391467;4570.405847239837;5274.7626356814035;5290.1800220965815;5293.655912365684;5298.3906850712665;5306.283651707047;6227.750889964351;6340.682965851781;6356.3325850785;6361;6401.103845461639;1636.5744906324442;1653.5866033491627;1654.8333424935392;1655.6523130142805;1657.1879778908249;1100.8293714474269;1101.0640955188026;1118.5805323003874;1118.770652016351;1122.5173175534435;6225.221847269091;6249.75000999964;6251.4061164189325;6257.843553911098;6258.405451482102;6603.306652801387;6604.174478190226;6606.570572912745;6610.3720146586;6613.933860661332;6086.573939824169;6143.631382117087;6215.968920155461;6312.810615681537;6315.715792789336;3567.518385018041;3575.1955809942556;3590.515280437108;3592.3533763922746;3599.9820000899826;6841.589504629738;6849.897251541231;6879.174499060145;6914.101166848278;6914.654267286716;6636.203655561363;6806.727730890808;6820.147481564804;6822.658867056627;6831;6887.621180835002;6888.207856096413;6894.379505844498;6898.413634841095;6905.723771049102;6611.702473388613;6658.733650654113;6662.100616416722;6665.233498147775;6669.866602668017;6363.5863668861375;6585.242697089704;6598.637074960923;6604.504662150454;6605.867882642224;6918.757843475454;6920.273371295942;6920.858058420305;6921.031055652112;6922.723091076301;4449.154660614473;4479.059397526556;4485.46174459067;4488.5287044861125;4492.842750503717;6455.935440645721;6631.834204144935;6681.2650608434005;6682.097916781172;6682.766103186365;6481.4166724994975;6488.772892948913;6493.350664933469;6494.64279464634;6496.577722448026;6406.13517175194;6450.129232553545;6450.161479007699;6455.677216139268;6459.6770161490795;6149.41580549847;6260.874782504416;6263.279722831932;6265.404786545271;6266.905996410149;6390.808275751735;6490.188726409199;6498.935010649833;6507.414332710079;6508.121403610452;6208.689565521796;6306.085617585516;6333;6355.269144048493;6357.586756860789 23:17:51 INFO - 2015-11-15 23:17:51,741 DEBUG : BROWSER_OUTPUT: |5;yui.html;752.161340105782;781.7732857471334;797.7638738299629;838.6310023589624;855.7347222361067;13829.239391833446;14218.431262749504;14231.288435578206;14242.71514569708;14254.643633909145;13060.477580896753;13104.148230365043;13321.13412628181;13567.525136620221;13573.728525429486;815.8776183572452;832.81261716114;833.8457385383693;834.1366685480529;834.4034015678789;822.4160845799489;824.0729179672868;829.3075282139391;830.3689196210863;832.4547421438937;851.7742798158492;856.8329175810719;859.6776208921655;860.1140824950311;860.1871231686059;852.2244757270854;852.3053711225363;852.5992783391796;853.3002937591177;853.4793775796759;619.683961179797;620.3455354600894;620.4787978098419;620.9130721698966;622.0793226025507;12032.639020829301;12145.149839511238;12146;12162.878371216262;12163.878361216452;10428.687139385831;10433.739156521071;10600.94699526505;10748;11475.655730328104;9849.458279794608;9856.852147217798;9895.554700038516;9923.950380248125;10100.141487973531;3226.774125811194;3277.0660361797013;3286.8849590264226;3305.4545999909988;3398.2863598644312;38158.80920595407;38517.61482385168;44982.77508612469;45902.344160096596;46442.30336544989;7356.558606483628;7389.371903388273;7481.9251807482315;7501.474896757284;7504.174540800507;12085.274883507018;12104.87895121055;12121.878781212252;12124.333161676192;12138.08964327679;6664.900026499607;6804.84317665998;6853.280405557444;6886.173659160932;6980.860382792316;4224.070704445017;4289.849855255114;4336.059479553904;4355.3684715716045;4360.694751367374;2824.5057115004793;2858.2997165694123;2860.5423132298733;2860.985695071511;2863.6993115722967;429.5489735777421;436.6594056635829;448.0255444408399;449.53024089825556;454.19380599436266;569.5415190771469;663.797541749771;666.7166454256921;668.4685674888475;703.5005146346049;8653.567321633893;8900.243479304203;8903.287736981027;9076.500792456478;9137.588808503633;542.9429909859487;627.9120923070774;655.8555320964947;681.2097966358999;701.8105111619834;4194.559571245037;4328.805203765838;4339.349097635317;4403.405540252089;4546.52261512543;59647.70176149091;59772;60052.39947600556;60181.69909150426;60228.698856506315;51761;53354.73322633362;53552;53760.73119634377;53907;43235.56764432316;43351;48443.757781210865;48493.27260091101;49086;8813.2949364052;8826.779330516532;8830.735077947671;9040.819183616422;9041.965557749454;35621.82189089038;35687.46468803022;36260.81869590635;36422.27155456929;36474.27051459009;43817.56182438135;50621;50995.49004510056;51145;51500.22749658833;7709.306162445182;7729.845403092019;7772.45592808498;7838.216178382117;7945.8808117879435;11454.427278635869;11534;11607.593734219261;11697.06423486136;12139.08956828259;11679.06567474583;11699.2980421175;11737.941310293394;11789.469473873867;11830.467628956545;11206.439678015904;11398.715032124263;11527.193096483501;11681.240719353214;11723.589674361356;11644.475998580254;11888.702782430508;11921.82117268259;11957.940210298893;11994.100442467025;9744.561013823135;10007.849882251627;10322.12261957742;10444.738881528023;10618.1505479563;9556.331056825955;10169.949150254497;10297.53661085238;10314.381137131797;10476.214283928888 23:17:51 INFO - 2015-11-15 23:17:51,741 DEBUG : BROWSER_OUTPUT: __end_tp_report 23:17:51 INFO - 2015-11-15 23:17:51,743 DEBUG : BROWSER_OUTPUT: __start_cc_report 23:17:51 INFO - 2015-11-15 23:17:51,743 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,807 23:17:51 INFO - 2015-11-15 23:17:51,743 DEBUG : BROWSER_OUTPUT: __end_cc_report 23:17:51 INFO - 2015-11-15 23:17:51,743 DEBUG : BROWSER_OUTPUT: __startTimestamp1447658271730__endTimestamp 23:17:51 INFO - 2015-11-15 23:17:51,743 DEBUG : BROWSER_OUTPUT: 23:17:51 INFO - 2015-11-15 23:17:51,743 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 23:17:51 INFO - 2015-11-15 23:17:51,743 DEBUG : BROWSER_OUTPUT: Number of tests: 6 23:17:51 INFO - 2015-11-15 23:17:51,743 DEBUG : BROWSER_OUTPUT: 23:17:51 INFO - 2015-11-15 23:17:51,743 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:5434.33 Median:5655.83 stddev:607.01 (10.7%) stddev-sans-first:581.95 23:17:51 INFO - 2015-11-15 23:17:51,743 DEBUG : BROWSER_OUTPUT: Values: 3155.4 3219.7 3262.9 3265.6 3296.4 5222.0 5299.4 5369.4 5430.8 5463.0 5363.8 5369.7 5417.4 5428.1 5509.9 4960.7 5044.8 5069.3 5073.8 5096.4 4819.6 5030.7 5059.1 5128.0 5134.0 4806.8 4916.5 4938.7 4954.7 4974.8 4930.4 4944.4 4948.9 4960.6 4994.9 4868.9 4940.0 4940.6 4941.9 4995.0 5202.0 5270.9 5302.8 5327.1 5339.6 5840.4 5863.2 5872.1 5872.3 5872.4 5799.9 5894.7 5906.6 5914.5 5915.3 5447.0 5490.8 5495.5 5504.2 5549.7 5904.2 5919.1 5925.8 5946.5 5976.5 5614.2 5740.2 5749.2 5760.5 5783.2 5830.4 5926.2 5937.8 5945.7 5994.4 5750.7 5765.5 5767.1 5769.5 5786.6 5613.1 5745.4 5754.5 5764.3 5790.7 4509.6 4521.3 4526.0 4540.6 4563.2 3981.8 3986.5 4024.6 4025.1 4031.6 5379.8 5480.4 5487.2 5589.0 5658.1 5839.2 5864.3 5866.8 5867.0 5871.3 5541.2 5554.4 5554.9 5556.4 5560.0 4977.0 5068.2 5068.5 5145.0 5164.7 6127.4 6140.3 6164.2 6166.7 6169.2 5666.8 5929.7 5930.3 5930.7 5931.4 5932.7 5988.3 5999.6 6033.0 6051.0 5836.1 5849.3 5854.7 5861.8 5894.3 5649.9 5779.4 5923.3 5927.8 5931.1 5651.2 5759.7 5798.1 5798.5 5801.1 5734.5 5734.7 5737.5 5740.4 5742.2 5582.3 5654.6 5655.8 5656.6 5658.7 5558.0 5660.3 5665.9 5702.3 5705.8 5546.3 5728.7 5728.9 5735.5 5765.3 23:17:51 INFO - 2015-11-15 23:17:51,743 DEBUG : BROWSER_OUTPUT: 23:17:51 INFO - 2015-11-15 23:17:51,744 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:44774.97 Median:174394.76 stddev:73888.62 (42.4%) stddev-sans-first:74021.35 23:17:51 INFO - 2015-11-15 23:17:51,744 DEBUG : BROWSER_OUTPUT: Values: 571.1 580.5 608.8 612.1 616.8 30723.4 39077.4 39864.4 39915.0 40155.6 42203.6 43061.8 43089.0 43091.8 43157.6 7622.0 7759.2 8716.9 8893.7 8897.4 10213.5 10368.2 10404.8 10416.3 10448.6 10069.6 10086.9 10146.1 10160.1 10163.8 7826.0 8002.0 10088.7 10507.6 10820.5 10244.3 10386.1 10410.2 10447.2 10451.6 39525.6 39872.0 40040.6 40043.8 40094.6 3172.6 3241.0 3446.0 3888.2 3908.4 29595.3 30002.0 30259.2 31007.4 31019.4 3437.7 3443.8 3500.9 3546.4 3604.2 270447.0 271134.0 271450.0 271475.0 271660.0 54887.5 55983.4 57118.0 58081.0 58284.5 52310.5 52376.0 52710.5 52719.5 52736.2 13298.9 13528.4 13565.9 13568.9 13574.7 9659.8 9718.2 9853.3 9884.3 9898.3 18910.3 18945.9 19042.0 19125.2 19125.8 6843.9 7136.0 7197.4 7225.1 7236.0 925.8 999.2 1029.4 1072.8 1073.4 27239.6 27987.9 28069.0 28496.4 28951.7 1023.6 1027.3 1044.5 1093.2 1107.8 14063.6 14164.2 14222.4 14252.6 14397.9 311802.0 316409.0 316426.0 316663.0 317089.0 43120.8 48971.8 49787.3 49822.8 50096.5 1280.3 1305.9 1306.0 1309.5 1310.8 25179.1 25297.2 25716.6 25800.5 25916.0 42111.2 43164.4 48016.5 49273.5 49293.5 257748.0 258924.0 258976.0 260766.0 260787.0 31209.2 31585.5 31651.4 31699.8 31700.5 40097.8 40507.2 41205.4 41216.8 41345.8 34673.5 34971.5 35231.0 35561.5 35676.0 34811.5 35141.6 35238.0 35404.8 35546.6 34898.8 35226.8 35477.5 36051.1 36143.8 27605.3 29127.7 30522.2 31392.7 31561.4 24405.9 24486.3 24526.6 24707.0 24733.4 23:17:51 INFO - 2015-11-15 23:17:51,744 DEBUG : BROWSER_OUTPUT: 23:17:51 INFO - 2015-11-15 23:17:51,744 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:28288.15 Median:24375.83 stddev:90526.77 (371.4%) stddev-sans-first:90756.42 23:17:51 INFO - 2015-11-15 23:17:51,744 DEBUG : BROWSER_OUTPUT: Values: 350.8 352.1 352.5 353.2 353.6 13787.9 14163.6 16554.0 16797.0 17468.5 15808.9 15839.4 15844.0 15911.3 15971.4 5119.2 5366.2 5369.7 5374.6 5380.4 3955.3 4086.4 5278.0 5835.6 5989.3 5901.1 5918.3 5921.2 5947.9 5948.0 5835.9 6013.1 6015.4 6021.4 6028.3 5170.7 5234.1 5265.6 5267.2 5268.5 19755.3 19998.5 20099.2 20151.9 20255.4 2056.7 2137.7 2213.9 2271.0 2691.8 12552.8 12915.1 12931.2 12953.7 12983.4 1680.0 1760.0 1819.5 1827.7 1884.3 58721.0 59305.1 59414.4 60111.4 60632.0 9445.5 9565.2 9691.6 9736.8 9813.8 12481.6 12486.4 12579.1 12593.4 12600.1 6996.5 7063.6 7073.6 7085.3 7093.3 6665.9 6737.3 6737.7 6744.4 6879.7 5692.3 5810.2 5813.2 5833.6 5854.2 1605.4 1642.0 1646.9 1650.4 1675.7 875.3 876.8 908.1 919.2 940.6 14156.8 16344.0 16512.4 16833.2 16956.8 473.1 481.7 945.2 996.2 1024.1 6265.1 6474.6 6548.3 6552.6 6556.7 536409.0 550169.0 558880.0 559975.0 560329.0 76379.0 78939.2 79164.6 80620.0 82142.2 553.0 566.2 566.5 566.9 567.4 10527.1 10988.9 11084.7 11099.6 11208.4 34765.8 35128.0 35485.5 36241.3 36637.6 46299.0 46892.3 48270.0 48660.8 48759.3 6788.6 6876.0 6878.6 6898.5 6903.4 10043.3 10306.9 12066.8 12148.9 12210.5 10185.1 10384.9 10451.1 10517.5 10587.9 9828.6 10071.1 10118.8 10293.2 10450.5 10341.2 10521.0 10536.0 10581.4 10678.9 6689.3 6709.4 6816.9 6817.7 6826.1 10610.1 10678.8 10811.2 10833.3 11052.7 23:17:51 INFO - 2015-11-15 23:17:51,744 DEBUG : BROWSER_OUTPUT: 23:17:51 INFO - 2015-11-15 23:17:51,744 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5203.73 Median:6345.02 stddev:2698.43 (42.5%) stddev-sans-first:2690.05 23:17:51 INFO - 2015-11-15 23:17:51,745 DEBUG : BROWSER_OUTPUT: Values: 1300.4 1667.4 1693.3 1695.3 1726.4 6656.1 7089.8 7203.6 7214.7 7222.6 7275.4 7368.4 7381.2 7389.2 7398.6 1934.1 1964.3 2158.8 2177.9 2183.4 2217.8 2229.9 2230.8 2233.2 2233.3 2128.1 2237.5 2239.8 2240.8 2242.6 1878.6 1916.9 2177.9 2208.9 2228.8 2236.6 2248.5 2276.4 2281.2 2283.1 7494.7 7551.1 7561.4 7573.8 7593.5 4474.3 4524.8 4548.1 4550.2 4550.5 2902.4 2963.7 2987.3 2999.4 3000.4 980.3 984.6 990.9 1016.0 1038.4 10428.2 10461.6 10464.2 10470.2 10481.1 3960.1 3989.9 4006.1 4191.6 4238.7 8950.6 8975.6 8991.0 8994.7 9010.1 4316.4 4321.6 4324.4 4325.9 4330.8 3948.1 3948.9 3950.1 3957.7 3958.5 3624.3 3658.9 3663.8 3672.7 3705.5 1149.9 1153.2 1153.7 1161.3 1163.4 966.7 1211.3 1219.0 1222.8 1244.0 6415.4 6778.5 7072.6 7074.4 7074.9 615.2 620.6 625.9 670.8 677.5 5208.3 5277.2 5313.9 5486.1 5489.2 8554.3 8642.5 8701.0 8724.5 8728.0 8531.2 8609.0 8653.3 8853.0 8883.7 6843.8 6888.2 6896.7 6929.7 6949.9 6504.8 6622.8 6633.1 6636.5 6673.9 7689.0 7841.9 7868.7 7878.9 7942.1 7939.3 7985.4 8055.3 8078.5 8110.3 6424.7 6436.3 6443.3 6461.4 6469.0 7080.0 7092.7 7163.8 7174.3 7176.0 6779.1 6813.0 6882.1 6964.7 7163.9 6965.9 6976.9 7016.4 7022.8 7113.5 6131.7 6209.1 7032.6 7055.4 7064.0 6265.3 6318.4 6329.1 6368.2 6413.3 6297.1 6343.4 6346.7 6351.4 6352.6 23:17:51 INFO - 2015-11-15 23:17:51,745 DEBUG : BROWSER_OUTPUT: 23:17:51 INFO - 2015-11-15 23:17:51,745 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:5347.82 Median:6115.10 stddev:1621.85 (26.5%) stddev-sans-first:1582.09 23:17:51 INFO - 2015-11-15 23:17:51,745 DEBUG : BROWSER_OUTPUT: Values: 331.1 331.7 338.7 341.7 343.3 5986.7 6027.5 6058.8 6075.1 6082.7 5705.9 5836.0 5875.7 5942.0 6007.1 4582.6 4595.8 4607.3 4615.0 4620.3 4393.8 4595.1 4609.0 4614.4 4617.4 4418.4 4446.3 4468.5 4497.6 4515.6 4449.7 4490.5 4491.2 4501.8 4511.5 3999.6 4002.2 4003.7 4004.0 4007.4 5534.1 5646.4 5652.9 5654.5 5659.4 5307.2 5311.5 5318.9 5319.7 5325.9 6282.6 6299.6 6308.4 6312.1 6316.4 4411.6 4416.1 4419.3 4432.4 4433.1 6422.2 6560.9 6584.9 6590.7 6596.7 4520.5 4524.8 4538.1 4540.2 4547.5 4562.9 4567.0 4568.9 4569.7 4570.4 5274.8 5290.2 5293.7 5298.4 5306.3 6227.8 6340.7 6356.3 6361.0 6401.1 1636.6 1653.6 1654.8 1655.7 1657.2 1100.8 1101.1 1118.6 1118.8 1122.5 6225.2 6249.8 6251.4 6257.8 6258.4 6603.3 6604.2 6606.6 6610.4 6613.9 6086.6 6143.6 6216.0 6312.8 6315.7 3567.5 3575.2 3590.5 3592.4 3600.0 6841.6 6849.9 6879.2 6914.1 6914.7 6636.2 6806.7 6820.1 6822.7 6831.0 6887.6 6888.2 6894.4 6898.4 6905.7 6611.7 6658.7 6662.1 6665.2 6669.9 6363.6 6585.2 6598.6 6604.5 6605.9 6918.8 6920.3 6920.9 6921.0 6922.7 4449.2 4479.1 4485.5 4488.5 4492.8 6455.9 6631.8 6681.3 6682.1 6682.8 6481.4 6488.8 6493.4 6494.6 6496.6 6406.1 6450.1 6450.2 6455.7 6459.7 6149.4 6260.9 6263.3 6265.4 6266.9 6390.8 6490.2 6498.9 6507.4 6508.1 6208.7 6306.1 6333.0 6355.3 6357.6 23:17:51 INFO - 2015-11-15 23:17:51,746 DEBUG : BROWSER_OUTPUT: 23:17:51 INFO - 2015-11-15 23:17:51,746 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:13588.00 Median:46172.32 stddev:16379.19 (35.5%) stddev-sans-first:16396.77 23:17:51 INFO - 2015-11-15 23:17:51,746 DEBUG : BROWSER_OUTPUT: Values: 752.2 781.8 797.8 838.6 855.7 13829.2 14218.4 14231.3 14242.7 14254.6 13060.5 13104.1 13321.1 13567.5 13573.7 815.9 832.8 833.8 834.1 834.4 822.4 824.1 829.3 830.4 832.5 851.8 856.8 859.7 860.1 860.2 852.2 852.3 852.6 853.3 853.5 619.7 620.3 620.5 620.9 622.1 12032.6 12145.1 12146.0 12162.9 12163.9 10428.7 10433.7 10600.9 10748.0 11475.7 9849.5 9856.9 9895.6 9924.0 10100.1 3226.8 3277.1 3286.9 3305.5 3398.3 38158.8 38517.6 44982.8 45902.3 46442.3 7356.6 7389.4 7481.9 7501.5 7504.2 12085.3 12104.9 12121.9 12124.3 12138.1 6664.9 6804.8 6853.3 6886.2 6980.9 4224.1 4289.8 4336.1 4355.4 4360.7 2824.5 2858.3 2860.5 2861.0 2863.7 429.5 436.7 448.0 449.5 454.2 569.5 663.8 666.7 668.5 703.5 8653.6 8900.2 8903.3 9076.5 9137.6 542.9 627.9 655.9 681.2 701.8 4194.6 4328.8 4339.3 4403.4 4546.5 59647.7 59772.0 60052.4 60181.7 60228.7 51761.0 53354.7 53552.0 53760.7 53907.0 43235.6 43351.0 48443.8 48493.3 49086.0 8813.3 8826.8 8830.7 9040.8 9042.0 35621.8 35687.5 36260.8 36422.3 36474.3 43817.6 50621.0 50995.5 51145.0 51500.2 7709.3 7729.8 7772.5 7838.2 7945.9 11454.4 11534.0 11607.6 11697.1 12139.1 11679.1 11699.3 11737.9 11789.5 11830.5 11206.4 11398.7 11527.2 11681.2 11723.6 11644.5 11888.7 11921.8 11957.9 11994.1 9744.6 10007.8 10322.1 10444.7 10618.2 9556.3 10169.9 10297.5 10314.4 10476.2 23:17:51 INFO - 2015-11-15 23:17:51,746 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 23:17:51 INFO - 2015-11-15 23:17:51,746 DEBUG : BROWSER_OUTPUT: 23:17:52 INFO - 2015-11-15 23:17:52,389 INFO : Browser exited with error code: 0 23:17:52 INFO - 2015-11-15 23:17:52,408 INFO : Completed test dromaeo_css (00:18:31) 23:17:52 INFO - 2015-11-15 23:17:52,408 INFO : Starting test kraken 23:17:52 INFO - 2015-11-15 23:17:52,408 DEBUG : operating with platform_type : linux_ 23:17:52 INFO - 2015-11-15 23:17:52,408 INFO : Initialising browser for kraken test... 23:17:52 INFO - 2015-11-15 23:17:52,414 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpMfJY55/profile http://localhost:37965/getInfo.html 23:17:56 INFO - 2015-11-15 23:17:56,171 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 23:17:56 INFO - 2015-11-15 23:17:56,171 DEBUG : BROWSER_OUTPUT: colorDepth:24 23:17:56 INFO - 2015-11-15 23:17:56,171 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 23:17:56 INFO - 2015-11-15 23:17:56,171 DEBUG : BROWSER_OUTPUT: __metrics 23:17:56 INFO - 2015-11-15 23:17:56,308 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 23:17:57 INFO - 2015-11-15 23:17:57,419 INFO : Browser initialized. 23:17:57 INFO - 2015-11-15 23:17:57,419 INFO : Running cycle 1/1 for kraken test... 23:17:57 INFO - 2015-11-15 23:17:57,420 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpMfJY55/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 23:18:09 INFO - 2015-11-15 23:18:09,160 DEBUG : BROWSER_OUTPUT: RSS: Main: 142622720 23:18:09 INFO - 2015-11-15 23:18:09,160 DEBUG : BROWSER_OUTPUT: 23:18:11 INFO - 2015-11-15 23:18:11,621 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37965/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:37965/tests/kraken/driver.html?testName=audio-beat-detection) 23:18:12 INFO - 2015-11-15 23:18:12,202 DEBUG : BROWSER_OUTPUT: RSS: Main: 180789248 23:18:12 INFO - 2015-11-15 23:18:12,202 DEBUG : BROWSER_OUTPUT: 23:18:14 INFO - 2015-11-15 23:18:14,783 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37965/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:37965/tests/kraken/driver.html?testName=audio-dft) 23:18:15 INFO - 2015-11-15 23:18:15,352 DEBUG : BROWSER_OUTPUT: RSS: Main: 168734720 23:18:15 INFO - 2015-11-15 23:18:15,353 DEBUG : BROWSER_OUTPUT: 23:18:18 INFO - 2015-11-15 23:18:18,244 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37965/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:37965/tests/kraken/driver.html?testName=audio-fft) 23:18:18 INFO - 2015-11-15 23:18:18,805 DEBUG : BROWSER_OUTPUT: RSS: Main: 151044096 23:18:18 INFO - 2015-11-15 23:18:18,805 DEBUG : BROWSER_OUTPUT: 23:18:20 INFO - 2015-11-15 23:18:20,784 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37965/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:37965/tests/kraken/driver.html?testName=audio-oscillator) 23:18:21 INFO - 2015-11-15 23:18:21,350 DEBUG : BROWSER_OUTPUT: RSS: Main: 154648576 23:18:21 INFO - 2015-11-15 23:18:21,350 DEBUG : BROWSER_OUTPUT: 23:18:23 INFO - 2015-11-15 23:18:23,531 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37965/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:37965/tests/kraken/driver.html?testName=imaging-gaussian-blur) 23:18:24 INFO - 2015-11-15 23:18:24,092 DEBUG : BROWSER_OUTPUT: RSS: Main: 156266496 23:18:24 INFO - 2015-11-15 23:18:24,092 DEBUG : BROWSER_OUTPUT: 23:18:27 INFO - 2015-11-15 23:18:27,004 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37965/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:37965/tests/kraken/driver.html?testName=imaging-darkroom) 23:18:27 INFO - 2015-11-15 23:18:27,573 DEBUG : BROWSER_OUTPUT: RSS: Main: 155598848 23:18:27 INFO - 2015-11-15 23:18:27,573 DEBUG : BROWSER_OUTPUT: 23:18:30 INFO - 2015-11-15 23:18:30,957 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37965/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:37965/tests/kraken/driver.html?testName=imaging-desaturate) 23:18:31 INFO - 2015-11-15 23:18:31,532 DEBUG : BROWSER_OUTPUT: RSS: Main: 157380608 23:18:31 INFO - 2015-11-15 23:18:31,532 DEBUG : BROWSER_OUTPUT: 23:18:34 INFO - 2015-11-15 23:18:34,283 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37965/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:37965/tests/kraken/driver.html?testName=json-parse-financial) 23:18:34 INFO - 2015-11-15 23:18:34,857 DEBUG : BROWSER_OUTPUT: RSS: Main: 157376512 23:18:34 INFO - 2015-11-15 23:18:34,857 DEBUG : BROWSER_OUTPUT: 23:18:36 INFO - 2015-11-15 23:18:36,413 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37965/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:37965/tests/kraken/driver.html?testName=json-stringify-tinderbox) 23:18:36 INFO - 2015-11-15 23:18:36,980 DEBUG : BROWSER_OUTPUT: RSS: Main: 165625856 23:18:36 INFO - 2015-11-15 23:18:36,980 DEBUG : BROWSER_OUTPUT: 23:18:38 INFO - 2015-11-15 23:18:38,775 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37965/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:37965/tests/kraken/driver.html?testName=stanford-crypto-aes) 23:18:39 INFO - 2015-11-15 23:18:39,369 DEBUG : BROWSER_OUTPUT: RSS: Main: 166436864 23:18:39 INFO - 2015-11-15 23:18:39,369 DEBUG : BROWSER_OUTPUT: 23:18:41 INFO - 2015-11-15 23:18:41,422 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37965/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:37965/tests/kraken/driver.html?testName=stanford-crypto-ccm) 23:18:41 INFO - 2015-11-15 23:18:41,996 DEBUG : BROWSER_OUTPUT: RSS: Main: 167346176 23:18:41 INFO - 2015-11-15 23:18:41,996 DEBUG : BROWSER_OUTPUT: 23:18:44 INFO - 2015-11-15 23:18:44,375 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37965/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:37965/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 23:18:44 INFO - 2015-11-15 23:18:44,960 DEBUG : BROWSER_OUTPUT: RSS: Main: 179236864 23:18:44 INFO - 2015-11-15 23:18:44,961 DEBUG : BROWSER_OUTPUT: 23:18:47 INFO - 2015-11-15 23:18:47,496 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37965/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:37965/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 23:18:48 INFO - 2015-11-15 23:18:48,077 DEBUG : BROWSER_OUTPUT: RSS: Main: 177479680 23:18:48 INFO - 2015-11-15 23:18:48,077 DEBUG : BROWSER_OUTPUT: 23:18:49 INFO - 2015-11-15 23:18:49,747 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37965/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:37965/tests/kraken/driver.html?testName=ai-astar) 23:18:49 INFO - 2015-11-15 23:18:49,993 DEBUG : BROWSER_OUTPUT: RSS: Main: 237027328 23:18:49 INFO - 2015-11-15 23:18:49,993 DEBUG : BROWSER_OUTPUT: 23:18:49 INFO - 2015-11-15 23:18:49,997 DEBUG : BROWSER_OUTPUT: __start_tp_report 23:18:49 INFO - 2015-11-15 23:18:49,997 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 23:18:49 INFO - 2015-11-15 23:18:49,997 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 23:18:49 INFO - 2015-11-15 23:18:49,997 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 23:18:49 INFO - 2015-11-15 23:18:49,997 DEBUG : BROWSER_OUTPUT: |0;ai-astar;109;112;105;110;111;112;101;111;115;111 23:18:49 INFO - 2015-11-15 23:18:49,998 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;145;128;159;159;126;152;159;125;164;125 23:18:49 INFO - 2015-11-15 23:18:49,998 DEBUG : BROWSER_OUTPUT: |2;audio-dft;161;161;160;159;160;158;161;163;162;161 23:18:49 INFO - 2015-11-15 23:18:49,998 DEBUG : BROWSER_OUTPUT: |3;audio-fft;72;73;86;93;71;71;73;116;89;72 23:18:50 INFO - 2015-11-15 23:18:49,998 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;91;91;139;90;90;90;135;92;91;137 23:18:50 INFO - 2015-11-15 23:18:49,998 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;109;109;110;109;109;109;109;110;109;108 23:18:50 INFO - 2015-11-15 23:18:49,998 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;146;147;146;148;145;146;146;147;146;146 23:18:50 INFO - 2015-11-15 23:18:49,998 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;96;96;96;95;96;95;96;96;96;95 23:18:50 INFO - 2015-11-15 23:18:49,998 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;60;60;59;58;59;59;59;68;57;58 23:18:50 INFO - 2015-11-15 23:18:49,999 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;67;68;68;68;69;69;68;69;69;69 23:18:50 INFO - 2015-11-15 23:18:49,999 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;85;92;84;84;83;84;84;85;86;85 23:18:50 INFO - 2015-11-15 23:18:49,999 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;121;119;117;115;119;114;120;121;126;124 23:18:50 INFO - 2015-11-15 23:18:49,999 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;138;148;147;149;151;138;148;147;151;137 23:18:50 INFO - 2015-11-15 23:18:49,999 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;69;66;72;68;67;67;68;68;65;65 23:18:50 INFO - 2015-11-15 23:18:49,999 DEBUG : BROWSER_OUTPUT: __end_tp_report 23:18:50 INFO - 2015-11-15 23:18:49,999 DEBUG : BROWSER_OUTPUT: __start_cc_report 23:18:50 INFO - 2015-11-15 23:18:50,000 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,913 23:18:50 INFO - 2015-11-15 23:18:50,000 DEBUG : BROWSER_OUTPUT: __end_cc_report 23:18:50 INFO - 2015-11-15 23:18:50,000 DEBUG : BROWSER_OUTPUT: __startTimestamp1447658329995__endTimestamp 23:18:50 INFO - 2015-11-15 23:18:50,000 DEBUG : BROWSER_OUTPUT: 23:18:50 INFO - 2015-11-15 23:18:50,003 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 23:18:50 INFO - 2015-11-15 23:18:50,003 DEBUG : BROWSER_OUTPUT: Number of tests: 14 23:18:50 INFO - 2015-11-15 23:18:50,003 DEBUG : BROWSER_OUTPUT: 23:18:50 INFO - 2015-11-15 23:18:50,004 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:109.70 Median:111.00 stddev:3.97 (3.6%) stddev-sans-first:4.21 23:18:50 INFO - 2015-11-15 23:18:50,004 DEBUG : BROWSER_OUTPUT: Values: 109.0 112.0 105.0 110.0 111.0 112.0 101.0 111.0 115.0 111.0 23:18:50 INFO - 2015-11-15 23:18:50,004 DEBUG : BROWSER_OUTPUT: 23:18:50 INFO - 2015-11-15 23:18:50,004 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:144.20 Median:155.50 stddev:16.47 (10.6%) stddev-sans-first:17.47 23:18:50 INFO - 2015-11-15 23:18:50,004 DEBUG : BROWSER_OUTPUT: Values: 145.0 128.0 159.0 159.0 126.0 152.0 159.0 125.0 164.0 125.0 23:18:50 INFO - 2015-11-15 23:18:50,004 DEBUG : BROWSER_OUTPUT: 23:18:50 INFO - 2015-11-15 23:18:50,004 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:160.60 Median:161.00 stddev:1.43 (0.9%) stddev-sans-first:1.51 23:18:50 INFO - 2015-11-15 23:18:50,004 DEBUG : BROWSER_OUTPUT: Values: 161.0 161.0 160.0 159.0 160.0 158.0 161.0 163.0 162.0 161.0 23:18:50 INFO - 2015-11-15 23:18:50,004 DEBUG : BROWSER_OUTPUT: 23:18:50 INFO - 2015-11-15 23:18:50,004 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:81.60 Median:73.00 stddev:14.70 (20.1%) stddev-sans-first:15.17 23:18:50 INFO - 2015-11-15 23:18:50,004 DEBUG : BROWSER_OUTPUT: Values: 72.0 73.0 86.0 93.0 71.0 71.0 73.0 116.0 89.0 72.0 23:18:50 INFO - 2015-11-15 23:18:50,004 DEBUG : BROWSER_OUTPUT: 23:18:50 INFO - 2015-11-15 23:18:50,004 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:104.60 Median:90.50 stddev:22.39 (24.7%) stddev-sans-first:23.20 23:18:50 INFO - 2015-11-15 23:18:50,004 DEBUG : BROWSER_OUTPUT: Values: 91.0 91.0 139.0 90.0 90.0 90.0 135.0 92.0 91.0 137.0 23:18:50 INFO - 2015-11-15 23:18:50,005 DEBUG : BROWSER_OUTPUT: 23:18:50 INFO - 2015-11-15 23:18:50,005 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:109.10 Median:109.00 stddev:0.57 (0.5%) stddev-sans-first:0.60 23:18:50 INFO - 2015-11-15 23:18:50,005 DEBUG : BROWSER_OUTPUT: Values: 109.0 109.0 110.0 109.0 109.0 109.0 109.0 110.0 109.0 108.0 23:18:50 INFO - 2015-11-15 23:18:50,005 DEBUG : BROWSER_OUTPUT: 23:18:50 INFO - 2015-11-15 23:18:50,005 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:146.30 Median:146.00 stddev:0.82 (0.6%) stddev-sans-first:0.87 23:18:50 INFO - 2015-11-15 23:18:50,005 DEBUG : BROWSER_OUTPUT: Values: 146.0 147.0 146.0 148.0 145.0 146.0 146.0 147.0 146.0 146.0 23:18:50 INFO - 2015-11-15 23:18:50,005 DEBUG : BROWSER_OUTPUT: 23:18:50 INFO - 2015-11-15 23:18:50,005 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:95.70 Median:96.00 stddev:0.48 (0.5%) stddev-sans-first:0.50 23:18:50 INFO - 2015-11-15 23:18:50,005 DEBUG : BROWSER_OUTPUT: Values: 96.0 96.0 96.0 95.0 96.0 95.0 96.0 96.0 96.0 95.0 23:18:50 INFO - 2015-11-15 23:18:50,005 DEBUG : BROWSER_OUTPUT: 23:18:50 INFO - 2015-11-15 23:18:50,005 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:59.70 Median:59.00 stddev:3.06 (5.2%) stddev-sans-first:3.24 23:18:50 INFO - 2015-11-15 23:18:50,005 DEBUG : BROWSER_OUTPUT: Values: 60.0 60.0 59.0 58.0 59.0 59.0 59.0 68.0 57.0 58.0 23:18:50 INFO - 2015-11-15 23:18:50,005 DEBUG : BROWSER_OUTPUT: 23:18:50 INFO - 2015-11-15 23:18:50,005 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:68.40 Median:69.00 stddev:0.70 (1.0%) stddev-sans-first:0.53 23:18:50 INFO - 2015-11-15 23:18:50,006 DEBUG : BROWSER_OUTPUT: Values: 67.0 68.0 68.0 68.0 69.0 69.0 68.0 69.0 69.0 69.0 23:18:50 INFO - 2015-11-15 23:18:50,006 DEBUG : BROWSER_OUTPUT: 23:18:50 INFO - 2015-11-15 23:18:50,006 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:85.20 Median:85.00 stddev:2.53 (3.0%) stddev-sans-first:2.68 23:18:50 INFO - 2015-11-15 23:18:50,006 DEBUG : BROWSER_OUTPUT: Values: 85.0 92.0 84.0 84.0 83.0 84.0 84.0 85.0 86.0 85.0 23:18:50 INFO - 2015-11-15 23:18:50,006 DEBUG : BROWSER_OUTPUT: 23:18:50 INFO - 2015-11-15 23:18:50,006 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:119.60 Median:120.50 stddev:3.72 (3.1%) stddev-sans-first:3.91 23:18:50 INFO - 2015-11-15 23:18:50,006 DEBUG : BROWSER_OUTPUT: Values: 121.0 119.0 117.0 115.0 119.0 114.0 120.0 121.0 126.0 124.0 23:18:50 INFO - 2015-11-15 23:18:50,006 DEBUG : BROWSER_OUTPUT: 23:18:50 INFO - 2015-11-15 23:18:50,006 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:145.40 Median:148.00 stddev:5.52 (3.7%) stddev-sans-first:5.17 23:18:50 INFO - 2015-11-15 23:18:50,006 DEBUG : BROWSER_OUTPUT: Values: 138.0 148.0 147.0 149.0 151.0 138.0 148.0 147.0 151.0 137.0 23:18:50 INFO - 2015-11-15 23:18:50,006 DEBUG : BROWSER_OUTPUT: 23:18:50 INFO - 2015-11-15 23:18:50,006 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.50 Median:68.00 stddev:2.07 (3.0%) stddev-sans-first:2.12 23:18:50 INFO - 2015-11-15 23:18:50,006 DEBUG : BROWSER_OUTPUT: Values: 69.0 66.0 72.0 68.0 67.0 67.0 68.0 68.0 65.0 65.0 23:18:50 INFO - 2015-11-15 23:18:50,006 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 23:18:50 INFO - 2015-11-15 23:18:50,006 DEBUG : BROWSER_OUTPUT: 23:18:50 INFO - 2015-11-15 23:18:50,861 INFO : Browser exited with error code: 0 23:18:50 INFO - 2015-11-15 23:18:50,914 INFO : Completed test kraken (00:00:58) 23:18:50 INFO - 2015-11-15 23:18:50,914 INFO : Starting test v8_7 23:18:50 INFO - 2015-11-15 23:18:50,914 DEBUG : operating with platform_type : linux_ 23:18:50 INFO - 2015-11-15 23:18:50,914 INFO : Initialising browser for v8_7 test... 23:18:50 INFO - 2015-11-15 23:18:50,920 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpHn_cwM/profile http://localhost:37965/getInfo.html 23:18:54 INFO - 2015-11-15 23:18:54,515 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 23:18:54 INFO - 2015-11-15 23:18:54,515 DEBUG : BROWSER_OUTPUT: colorDepth:24 23:18:54 INFO - 2015-11-15 23:18:54,515 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 23:18:54 INFO - 2015-11-15 23:18:54,515 DEBUG : BROWSER_OUTPUT: __metrics 23:18:54 INFO - 2015-11-15 23:18:54,677 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 23:18:55 INFO - 2015-11-15 23:18:55,891 INFO : Browser initialized. 23:18:55 INFO - 2015-11-15 23:18:55,892 INFO : Running cycle 1/1 for v8_7 test... 23:18:55 INFO - 2015-11-15 23:18:55,892 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpHn_cwM/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 23:19:07 INFO - 2015-11-15 23:19:07,604 DEBUG : BROWSER_OUTPUT: RSS: Main: 141762560 23:19:07 INFO - 2015-11-15 23:19:07,605 DEBUG : BROWSER_OUTPUT: 23:19:29 INFO - 2015-11-15 23:19:29,060 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37965/tests/v8_7/run.html (next: http://localhost:37965/tests/v8_7/run.html) 23:19:29 INFO - 2015-11-15 23:19:29,306 DEBUG : BROWSER_OUTPUT: RSS: Main: 621154304 23:19:29 INFO - 2015-11-15 23:19:29,306 DEBUG : BROWSER_OUTPUT: 23:19:29 INFO - 2015-11-15 23:19:29,307 DEBUG : BROWSER_OUTPUT: __start_tp_report 23:19:29 INFO - 2015-11-15 23:19:29,307 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 23:19:29 INFO - 2015-11-15 23:19:29,308 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 23:19:29 INFO - 2015-11-15 23:19:29,308 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 23:19:29 INFO - 2015-11-15 23:19:29,308 DEBUG : BROWSER_OUTPUT: |0;Richards;170.7067258449983 23:19:29 INFO - 2015-11-15 23:19:29,308 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;188.21757952192735 23:19:29 INFO - 2015-11-15 23:19:29,308 DEBUG : BROWSER_OUTPUT: |2;Encrypt;280.74115665356544 23:19:29 INFO - 2015-11-15 23:19:29,308 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5035.175879396985 23:19:29 INFO - 2015-11-15 23:19:29,308 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1100 23:19:29 INFO - 2015-11-15 23:19:29,309 DEBUG : BROWSER_OUTPUT: |5;Earley;808.4074373484236 23:19:29 INFO - 2015-11-15 23:19:29,309 DEBUG : BROWSER_OUTPUT: |6;Boyer;12195.121951219513 23:19:29 INFO - 2015-11-15 23:19:29,309 DEBUG : BROWSER_OUTPUT: |7;RegExp;25820.51282051282 23:19:29 INFO - 2015-11-15 23:19:29,309 DEBUG : BROWSER_OUTPUT: |8;Splay;641.8962203715568 23:19:29 INFO - 2015-11-15 23:19:29,309 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4826.923076923077 23:19:29 INFO - 2015-11-15 23:19:29,309 DEBUG : BROWSER_OUTPUT: __end_tp_report 23:19:29 INFO - 2015-11-15 23:19:29,309 DEBUG : BROWSER_OUTPUT: __startTimestamp1447658369306__endTimestamp 23:19:29 INFO - 2015-11-15 23:19:29,309 DEBUG : BROWSER_OUTPUT: 23:19:29 INFO - 2015-11-15 23:19:29,310 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 23:19:29 INFO - 2015-11-15 23:19:29,310 DEBUG : BROWSER_OUTPUT: Number of tests: 10 23:19:29 INFO - 2015-11-15 23:19:29,310 DEBUG : BROWSER_OUTPUT: 23:19:29 INFO - 2015-11-15 23:19:29,310 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:170.71 Median:170.71 stddev:0.00 (0.0%) 23:19:29 INFO - 2015-11-15 23:19:29,310 DEBUG : BROWSER_OUTPUT: Values: 170.7 23:19:29 INFO - 2015-11-15 23:19:29,310 DEBUG : BROWSER_OUTPUT: 23:19:29 INFO - 2015-11-15 23:19:29,310 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:188.22 Median:188.22 stddev:0.00 (0.0%) 23:19:29 INFO - 2015-11-15 23:19:29,311 DEBUG : BROWSER_OUTPUT: Values: 188.2 23:19:29 INFO - 2015-11-15 23:19:29,311 DEBUG : BROWSER_OUTPUT: 23:19:29 INFO - 2015-11-15 23:19:29,311 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:280.74 Median:280.74 stddev:0.00 (0.0%) 23:19:29 INFO - 2015-11-15 23:19:29,311 DEBUG : BROWSER_OUTPUT: Values: 280.7 23:19:29 INFO - 2015-11-15 23:19:29,311 DEBUG : BROWSER_OUTPUT: 23:19:29 INFO - 2015-11-15 23:19:29,311 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5035.18 Median:5035.18 stddev:0.00 (0.0%) 23:19:29 INFO - 2015-11-15 23:19:29,311 DEBUG : BROWSER_OUTPUT: Values: 5035.2 23:19:29 INFO - 2015-11-15 23:19:29,311 DEBUG : BROWSER_OUTPUT: 23:19:29 INFO - 2015-11-15 23:19:29,311 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1100.00 Median:1100.00 stddev:0.00 (0.0%) 23:19:29 INFO - 2015-11-15 23:19:29,312 DEBUG : BROWSER_OUTPUT: Values: 1100.0 23:19:29 INFO - 2015-11-15 23:19:29,312 DEBUG : BROWSER_OUTPUT: 23:19:29 INFO - 2015-11-15 23:19:29,312 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:808.41 Median:808.41 stddev:0.00 (0.0%) 23:19:29 INFO - 2015-11-15 23:19:29,312 DEBUG : BROWSER_OUTPUT: Values: 808.4 23:19:29 INFO - 2015-11-15 23:19:29,312 DEBUG : BROWSER_OUTPUT: 23:19:29 INFO - 2015-11-15 23:19:29,312 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:12195.12 Median:12195.12 stddev:0.00 (0.0%) 23:19:29 INFO - 2015-11-15 23:19:29,312 DEBUG : BROWSER_OUTPUT: Values: 12195.1 23:19:29 INFO - 2015-11-15 23:19:29,312 DEBUG : BROWSER_OUTPUT: 23:19:29 INFO - 2015-11-15 23:19:29,312 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:25820.51 Median:25820.51 stddev:0.00 (0.0%) 23:19:29 INFO - 2015-11-15 23:19:29,312 DEBUG : BROWSER_OUTPUT: Values: 25820.5 23:19:29 INFO - 2015-11-15 23:19:29,313 DEBUG : BROWSER_OUTPUT: 23:19:29 INFO - 2015-11-15 23:19:29,313 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:641.90 Median:641.90 stddev:0.00 (0.0%) 23:19:29 INFO - 2015-11-15 23:19:29,313 DEBUG : BROWSER_OUTPUT: Values: 641.9 23:19:29 INFO - 2015-11-15 23:19:29,313 DEBUG : BROWSER_OUTPUT: 23:19:29 INFO - 2015-11-15 23:19:29,313 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4826.92 Median:4826.92 stddev:0.00 (0.0%) 23:19:29 INFO - 2015-11-15 23:19:29,313 DEBUG : BROWSER_OUTPUT: Values: 4826.9 23:19:29 INFO - 2015-11-15 23:19:29,313 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 23:19:29 INFO - 2015-11-15 23:19:29,313 DEBUG : BROWSER_OUTPUT: 23:19:30 INFO - 2015-11-15 23:19:30,133 INFO : Browser exited with error code: 0 23:19:30 INFO - 2015-11-15 23:19:30,152 INFO : Completed test v8_7 (00:00:39) 23:19:30 INFO - 2015-11-15 23:19:30,254 INFO : Completed test suite (00:20:09) 23:19:30 INFO - 2015-11-15 23:19:30,255 DEBUG : Working with test: dromaeo_css 23:19:30 INFO - 2015-11-15 23:19:30,255 DEBUG : Generating results file: dromaeo_css 23:19:30 INFO - 2015-11-15 23:19:30,256 DEBUG : Working with test: kraken 23:19:30 INFO - 2015-11-15 23:19:30,256 DEBUG : Generating results file: kraken 23:19:30 INFO - 2015-11-15 23:19:30,257 INFO : javascript benchmark 23:19:30 INFO - 2015-11-15 23:19:30,257 DEBUG : Working with test: v8_7 23:19:30 INFO - 2015-11-15 23:19:30,257 DEBUG : Generating results file: v8_7 23:19:30 INFO - 2015-11-15 23:19:30,258 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 23:19:30 INFO - 2015-11-15 23:19:30,312 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,201,35]] 23:19:30 INFO - 2015-11-15 23:19:30,312 DEBUG : process_Request line: dromaeo_css 6787.92 graph.html#tests=[[72,201,35]] 23:19:30 INFO - 2015-11-15 23:19:30,312 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 23:19:30 INFO - 2015-11-15 23:19:30,347 DEBUG : process_Request line: kraken 1497.60 graph.html#tests=[[232,201,35]] 23:19:30 INFO - 2015-11-15 23:19:30,347 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 23:19:30 INFO - 2015-11-15 23:19:30,374 DEBUG : process_Request line: v8_7 20887.92 graph.html#tests=[[230,201,35]] 23:19:30 INFO - 2015-11-15 23:19:30,376 INFO : javascript benchmark 23:19:30 INFO - 2015-11-15 23:19:30,380 INFO : TALOSDATA: [{"talos_counters": {}, "results": {"jquery.html": [350.83160083160084, 352.08809184212885, 352.53289391556194, 353.1630036812753, 353.57041194948135, 13787.931060344685, 14163.575092747235, 16554.0, 16797.0, 17468.47594572163, 15808.920955395235, 15839.445619403323, 15844.0, 15911.28399222035, 15971.361145554163, 5119.206522988924, 5366.248725178459, 5369.731513424333, 5374.596905232103, 5380.408155102936, 3955.2880481513316, 4086.3870419437026, 5278.023565640369, 5835.5915085944, 5989.311229208632, 5901.085331773582, 5918.319393269764, 5921.230240068785, 5947.910781338283, 5948.0, 5835.912461313083, 6013.128096425994, 6015.428534289235, 6021.42796434338, 6028.276606807167, 5170.741462926876, 5234.136367499358, 5265.631405801557, 5267.1835865440535, 5268.525832675077, 19755.308564200182, 19998.500037499034, 20099.196032158696, 20151.899240503702, 20255.392338229878, 2056.7223424837607, 2137.6900349449243, 2213.944651383712, 2271.0, 2691.8384896906055, 12552.8117078243, 12915.095943283974, 12931.159474634118, 12953.740925181537, 12983.415746291439, 1679.971818547159, 1759.9912000439915, 1819.46325833878, 1827.6801559726994, 1884.293389978758, 58721.0, 59305.110423343685, 59414.40585594175, 60111.398886011455, 60632.0, 9445.527723613792, 9565.186959108554, 9691.563879625433, 9736.75658108553, 9813.754656133653, 12481.56314528987, 12486.376771019892, 12579.11946163778, 12593.37033148339, 12600.11799174049, 6996.510244282953, 7063.5761854287875, 7073.575585464889, 7085.291470852977, 7093.290670932865, 6665.900011499832, 6737.326267373223, 6737.730490780412, 6744.393004629607, 6879.6560171992205, 5692.345380281321, 5810.157527158538, 5813.244278243801, 5833.591648584643, 5854.151148083504, 1605.3658804772049, 1641.9917900410421, 1646.9011859288241, 1650.4058538925976, 1675.7067513185143, 875.3216257400566, 876.8465518534231, 908.14180599333, 919.2186641354929, 940.557937769261, 14156.787648185285, 16344.0, 16512.42206522766, 16833.158342082847, 16956.830431695773, 473.07985967293973, 481.6556162343941, 945.2154711589365, 996.1582462818907, 1024.144839059379, 6265.122882796412, 6474.611523308617, 6548.264709851893, 6552.57408268461, 6556.672166391757, 536409.0, 550169.0, 558880.0, 559975.0, 560329.0, 76379.0, 78939.21060789433, 79164.6041769799, 80620.0, 82142.17857821465, 552.9612927095145, 566.1875209074908, 566.5411017076182, 566.9149627555818, 567.4042255631571, 10527.105196058421, 10988.890111098786, 11084.722881928017, 11099.556017759522, 11208.383538905438, 34765.82617086898, 35128.0, 35485.46771798374, 36241.27517449584, 36637.63362366342, 46299.0, 46892.29661555147, 48270.0, 48660.75669621771, 48759.26861097015, 6788.558743681645, 6876.037354770237, 6878.58728476293, 6898.517103802887, 6903.413209877016, 10043.347182433119, 10306.948465257627, 12066.818997714865, 12148.878511214774, 12210.511579536718, 10185.08334249921, 10384.948075259575, 10451.059404653617, 10517.474126293502, 10587.947060264958, 9828.606855725977, 10071.143952764098, 10118.8482172766, 10293.176545876462, 10450.477476126316, 10341.224408169266, 10521.0, 10536.0, 10581.36511809294, 10678.89321106779, 6689.331066893272, 6709.396154346132, 6816.931830681629, 6817.7272909083085, 6826.112605361272, 10610.098141658045, 10678.786424271626, 10811.243212975016, 10833.29583577065, 11052.668419947415], "dojo.html": [3155.4320222359975, 3219.7424206063515, 3262.8694852205913, 3265.5754751882237, 3296.4231259529574, 5222.0, 5299.417064122943, 5369.409364969855, 5430.83707488775, 5462.972685136574, 5363.758630861611, 5369.650972686783, 5417.404085550586, 5428.050091234038, 5509.944900550993, 4960.6775559588605, 5044.82343117991, 5069.2649565812935, 5073.847784566469, 5096.413912400084, 4819.638527110481, 5030.723310217936, 5059.089363914494, 5128.000039992203, 5134.0245353382925, 4806.783694733728, 4916.50834916509, 4938.654294199408, 4954.7274899880495, 4974.77613507393, 4930.433000204951, 4944.35723355965, 4948.87627809304, 4960.553550180501, 4994.900101997976, 4868.9269660955115, 4939.962607852355, 4940.55535001848, 4941.851744447672, 4994.950050499485, 5201.973990130063, 5270.947290527084, 5302.761375738101, 5327.147656375, 5339.599530035224, 5840.445157710011, 5863.208466856962, 5872.060470324727, 5872.324682661463, 5872.412758724136, 5799.88400231993, 5894.734736936805, 5906.5570082244, 5914.467697907209, 5915.290165180163, 5447.046766815831, 5490.780368785204, 5495.53287970523, 5504.2294078829, 5549.667019978774, 5904.232449781587, 5919.141724450017, 5925.792597259076, 5946.464818166386, 5976.462118409364, 5614.157876318585, 5740.196372507852, 5749.195112684228, 5760.481556659921, 5783.161441590946, 5830.38780928005, 5926.229590153339, 5937.7921772737745, 5945.702714864239, 5994.430529099728, 5750.741216645261, 5765.509931655856, 5767.077267637158, 5769.509591684669, 5786.566007549451, 5613.073842815971, 5745.368009518949, 5754.4533269339345, 5764.279465066867, 5790.739416726257, 4509.616682582017, 4521.276595744665, 4525.954740452619, 4540.614047805908, 4563.224251877189, 3981.8407263709128, 3986.5415477219913, 4024.63778259958, 4025.134596061861, 4031.637152656216, 5379.811706590251, 5480.369757477862, 5487.204355368449, 5589.049861523551, 5658.122990936411, 5839.240898683229, 5864.296284445893, 5866.823995280149, 5867.0, 5871.32479764824, 5541.168824676251, 5554.389017208104, 5554.91667624986, 5556.388797232301, 5560.026995275811, 4976.950230497721, 5068.189089745623, 5068.493150684976, 5144.9742751286, 5164.664296820694, 6127.417895300028, 6140.263168419819, 6164.229471316085, 6166.660833654102, 6169.198004259418, 5666.801661941977, 5929.703514824155, 5930.347661757117, 5930.703464826827, 5931.406859314034, 5932.673702946379, 5988.341282459013, 5999.610025348338, 6033.0, 6051.031834906394, 5836.095405212199, 5849.298084229919, 5854.677992710442, 5861.794837180678, 5894.2926848778425, 5649.858753531194, 5779.36426993022, 5923.348431672599, 5927.792527261525, 5931.08068249422, 5651.180578816131, 5759.683217422914, 5798.072308430631, 5798.507126894093, 5801.129830525455, 5734.5125664319, 5734.684592347294, 5737.483626473638, 5740.39725828782, 5742.224799651994, 5582.302212223472, 5654.6324488908085, 5655.830325090254, 5656.632318899258, 5658.745356459051, 5558.0, 5660.349059858169, 5665.915011274752, 5702.287214098238, 5705.771769129188, 5546.278983732089, 5728.656280623176, 5728.942710573007, 5735.512481438957, 5765.336986246468], "mootools.html": [1300.3823183987602, 1667.441407128612, 1693.2549678141609, 1695.279506209861, 1726.3612463388545, 6656.134702488675, 7089.822754431142, 7203.639818009105, 7214.675339609717, 7222.638868056602, 7275.417966562675, 7368.447366447511, 7381.188069312371, 7389.2241314662, 7398.593077380742, 1934.139308007937, 1964.2830366916044, 2158.7949144831255, 2177.858439201455, 2183.410479170623, 2217.800397964183, 2229.8550594211406, 2230.7992280694734, 2233.196049422215, 2233.3188377544843, 2128.1168315149193, 2237.5301186750803, 2239.8096161826184, 2240.831937604686, 2242.6187548116777, 1878.6242751449697, 1916.9041547922548, 2177.934661960144, 2208.9116435342726, 2228.7882651148116, 2236.630955892276, 2248.5278091600785, 2276.362618466832, 2281.167373908528, 2283.1095872609694, 7494.6627401767055, 7551.131619863731, 7561.395088392916, 7573.848523029564, 7593.544387336778, 4474.2841145416905, 4524.8416305429155, 4548.135854187727, 4550.226461501553, 4550.453945526525, 2902.4485347783852, 2963.659179194399, 2987.3129180288656, 2999.43010827942, 3000.3999200159838, 980.3039841712392, 984.6110786239395, 990.8810942686923, 1016.044917777287, 1038.3717850700293, 10428.165746740318, 10461.581536738522, 10464.215183861164, 10470.162387009097, 10481.056704896597, 3960.128771670228, 3989.860354887565, 4006.138680183716, 4191.601797829201, 4238.724482908663, 8950.597223124974, 8975.551222438851, 8990.955045224731, 8994.685186018458, 9010.053944335881, 4316.395704601358, 4321.58944900234, 4324.372965919924, 4325.935110973338, 4330.848420305274, 3948.1116748731306, 3948.861789837342, 3950.051987523031, 3957.722959392815, 3958.5051868516434, 3624.311380837685, 3658.8536458541894, 3663.780173189617, 3672.7245456590863, 3705.481232627434, 1149.896509314149, 1153.1870031627682, 1153.7173392518719, 1161.3206274329443, 1163.3775929877474, 966.7438128895848, 1211.3337664284609, 1218.9878101218874, 1222.7860124478182, 1243.9502419903104, 6415.358464153547, 6778.525503214826, 7072.646367681698, 7074.398676112588, 7074.858502829915, 615.1725928625991, 620.5501011766434, 625.8810825943057, 670.8289386206486, 677.5325025732327, 5208.270842082112, 5277.234800953917, 5313.946860531422, 5486.067368547357, 5489.204065410493, 8554.27288680469, 8642.481451112953, 8701.042885282613, 8724.476531408136, 8727.956360218159, 8531.189536993976, 8609.0, 8653.307735381155, 8852.955735221283, 8883.689070882489, 6843.828904277333, 6888.173419189629, 6896.689648965808, 6929.688164032631, 6949.895751563629, 6504.837379065561, 6622.8344291393105, 6633.1045308882685, 6636.535442519171, 6673.9332606673315, 7689.0, 7841.921580784119, 7868.72459463916, 7878.881816772639, 7942.12636609984, 7939.325157361689, 7985.441019128838, 8055.3152981994845, 8078.515289082438, 8110.270075693216, 6424.743010279723, 6436.292007879223, 6443.259025212161, 6461.418472337512, 6469.0, 7080.0, 7092.716291348494, 7163.820904477429, 7174.3184397482155, 7176.031235783311, 6779.118714567075, 6812.965935170292, 6882.070920425678, 6964.686589103604, 7163.8567228656175, 6965.895511567229, 6976.860462790817, 7016.403605693573, 7022.789316320519, 7113.466490013167, 6131.693415329305, 6209.130721699056, 7032.648367581703, 7055.435565154878, 7064.046353742385, 6265.342139075331, 6318.368163183829, 6329.050642403677, 6368.172137622079, 6413.262474815456, 6297.118403423616, 6343.365663433619, 6346.682665866781, 6351.396617321347, 6352.555321127476], "ext.html": [571.0634559322709, 580.465971306398, 608.7747533412638, 612.1216054961131, 616.8457885528618, 30723.38553228937, 39077.4138387924, 39864.40203396951, 39915.0, 40155.59844401555, 42203.57796422035, 43061.7846910765, 43089.0, 43091.78454107733, 43157.568424315745, 7622.047244094489, 7759.1852855450215, 8716.912830871705, 8893.68872089477, 8897.377183597151, 10213.48932553373, 10368.170546356274, 10404.843927341059, 10416.27086103973, 10448.63429779958, 10069.64756233532, 10086.949565252164, 10146.086852183302, 10160.136388406994, 10163.796724065514, 7826.0, 8001.95999020007, 10088.74778130549, 10507.632232871812, 10820.513076911559, 10244.28290019699, 10386.11718003963, 10410.219233557438, 10447.164226861833, 10451.581936722521, 39525.628462292065, 39872.0, 40040.59959400398, 40043.7997810012, 40094.59905400938, 3172.6034245719284, 3240.983795081033, 3445.9655403445895, 3888.241792850395, 3908.4137379393032, 29595.260118496994, 30002.0, 30259.243518911982, 31007.379852402824, 31019.379612407625, 3437.74216933731, 3443.8450269737673, 3500.9474857877153, 3546.414841551141, 3604.1530240393486, 270447.0, 271134.0, 271450.0, 271475.0, 271660.0, 54887.45112548903, 55983.44016559864, 57118.0, 58081.0, 58284.54288642733, 52310.47689523056, 52376.0, 52710.47289527133, 52719.472805271456, 52736.20895686568, 13298.933505332412, 13528.39122239482, 13565.864341356657, 13568.864311356958, 13574.660633484242, 9659.806803864023, 9718.222542196607, 9853.261005424622, 9884.258680598983, 9898.257630677728, 18910.338138165098, 18945.90527047356, 19042.0, 19125.23499060022, 19125.808741912402, 6843.931560684329, 7136.0, 7197.352238298578, 7225.060742103493, 7235.963820180866, 925.7685578605349, 999.160705007797, 1029.444100185906, 1072.8337107748312, 1073.4418102586612, 27239.591406128922, 27987.86006069997, 28069.0, 28496.430071398456, 28951.7104828949, 1023.6366090038078, 1027.2963020331097, 1044.5395230499385, 1093.1637297467444, 1107.7673688525338, 14063.648408789863, 14164.22096784666, 14222.359993800304, 14252.643683907778, 14397.928010359881, 311802.0, 316409.0, 316426.0, 316663.0, 317089.0, 43120.784396078445, 48971.755141224065, 49787.25319120216, 49822.75088624606, 50096.49903500991, 1280.2766436963086, 1305.902057345684, 1306.0139594606012, 1309.5285697149018, 1310.8099325597734, 25179.118730844333, 25297.241082767545, 25716.61425078588, 25800.483990320463, 25916.0, 42111.157776844906, 43164.352534711375, 48016.519834801205, 49273.50726492689, 49293.50706493032, 257748.0, 258924.0, 258976.0, 260766.0, 260787.0, 31209.219769505944, 31585.5262171063, 31651.36697266088, 31699.84150079327, 31700.524492132176, 40097.799511003424, 40507.1898562033, 41205.38191927184, 41216.79391603143, 41345.79327103345, 34673.47989780105, 34971.47542786809, 35231.0, 35561.466578000836, 35676.0, 34811.47782783311, 35141.64858351486, 35238.0, 35404.822975884956, 35546.64453355433, 34898.82550587231, 35226.823865880506, 35477.467837982964, 36051.098722532144, 36143.81928090343, 27605.309867252676, 29127.7087229125, 30522.236944076576, 31392.68607313989, 31561.36877262488, 24405.877970610032, 24486.26541203767, 24526.63210051815, 24707.0, 24733.381665458506], "prototype.html": [331.07299561228564, 331.65010913486265, 338.71040260577206, 341.6515154542367, 343.2774010707459, 5986.700664966751, 6027.457528822405, 6058.787942422016, 6075.149479072922, 6082.665453400066, 5705.857353566163, 5835.978703726842, 5875.7062146892695, 5942.0, 6007.068904319837, 4582.587567118959, 4595.839145629912, 4607.262837945929, 4614.953850461503, 4620.260758278676, 4393.824247030131, 4595.126925884088, 4608.953910460886, 4614.446266448031, 4617.422822147231, 4418.447694038246, 4446.333050042504, 4468.530804265554, 4497.640188784906, 4515.61617262533, 4449.688521803475, 4490.50604433512, 4491.23648979671, 4501.774911254457, 4511.52628973958, 3999.600039996006, 4002.1595464952393, 4003.739756915791, 4004.0, 4007.4189242559955, 5534.05920993428, 5646.378898321182, 5652.943470565283, 5654.491095801398, 5659.377468478464, 5307.230451584537, 5311.495407936279, 5318.920216196721, 5319.707416092114, 5325.946740532584, 6282.560220784547, 6299.5905266158015, 6308.369163083701, 6312.053192021188, 6316.431521163071, 4411.558844115562, 4416.116776644684, 4419.270820314644, 4432.401625780542, 4433.091216300651, 6422.165118534607, 6560.868782624369, 6584.93415065848, 6590.703418346186, 6596.703148358335, 4520.4575450946095, 4524.796384162721, 4538.092381523708, 4540.182767101887, 4547.522510136454, 4562.908741825211, 4567.0, 4568.88577785558, 4569.680122391467, 4570.405847239837, 5274.7626356814035, 5290.1800220965815, 5293.655912365684, 5298.3906850712665, 5306.283651707047, 6227.750889964351, 6340.682965851781, 6356.3325850785, 6361.0, 6401.103845461639, 1636.5744906324442, 1653.5866033491627, 1654.8333424935392, 1655.6523130142805, 1657.1879778908249, 1100.8293714474269, 1101.0640955188026, 1118.5805323003874, 1118.770652016351, 1122.5173175534435, 6225.221847269091, 6249.75000999964, 6251.4061164189325, 6257.843553911098, 6258.405451482102, 6603.306652801387, 6604.174478190226, 6606.570572912745, 6610.3720146586, 6613.933860661332, 6086.573939824169, 6143.631382117087, 6215.968920155461, 6312.810615681537, 6315.715792789336, 3567.518385018041, 3575.1955809942556, 3590.515280437108, 3592.3533763922746, 3599.9820000899826, 6841.589504629738, 6849.897251541231, 6879.174499060145, 6914.101166848278, 6914.654267286716, 6636.203655561363, 6806.727730890808, 6820.147481564804, 6822.658867056627, 6831.0, 6887.621180835002, 6888.207856096413, 6894.379505844498, 6898.413634841095, 6905.723771049102, 6611.702473388613, 6658.733650654113, 6662.100616416722, 6665.233498147775, 6669.866602668017, 6363.5863668861375, 6585.242697089704, 6598.637074960923, 6604.504662150454, 6605.867882642224, 6918.757843475454, 6920.273371295942, 6920.858058420305, 6921.031055652112, 6922.723091076301, 4449.154660614473, 4479.059397526556, 4485.46174459067, 4488.5287044861125, 4492.842750503717, 6455.935440645721, 6631.834204144935, 6681.2650608434005, 6682.097916781172, 6682.766103186365, 6481.4166724994975, 6488.772892948913, 6493.350664933469, 6494.64279464634, 6496.577722448026, 6406.13517175194, 6450.129232553545, 6450.161479007699, 6455.677216139268, 6459.6770161490795, 6149.41580549847, 6260.874782504416, 6263.279722831932, 6265.404786545271, 6266.905996410149, 6390.808275751735, 6490.188726409199, 6498.935010649833, 6507.414332710079, 6508.121403610452, 6208.689565521796, 6306.085617585516, 6333.0, 6355.269144048493, 6357.586756860789], "yui.html": [752.161340105782, 781.7732857471334, 797.7638738299629, 838.6310023589624, 855.7347222361067, 13829.239391833446, 14218.431262749504, 14231.288435578206, 14242.71514569708, 14254.643633909145, 13060.477580896753, 13104.148230365043, 13321.13412628181, 13567.525136620221, 13573.728525429486, 815.8776183572452, 832.81261716114, 833.8457385383693, 834.1366685480529, 834.4034015678789, 822.4160845799489, 824.0729179672868, 829.3075282139391, 830.3689196210863, 832.4547421438937, 851.7742798158492, 856.8329175810719, 859.6776208921655, 860.1140824950311, 860.1871231686059, 852.2244757270854, 852.3053711225363, 852.5992783391796, 853.3002937591177, 853.4793775796759, 619.683961179797, 620.3455354600894, 620.4787978098419, 620.9130721698966, 622.0793226025507, 12032.639020829301, 12145.149839511238, 12146.0, 12162.878371216262, 12163.878361216452, 10428.687139385831, 10433.739156521071, 10600.94699526505, 10748.0, 11475.655730328104, 9849.458279794608, 9856.852147217798, 9895.554700038516, 9923.950380248125, 10100.141487973531, 3226.774125811194, 3277.0660361797013, 3286.8849590264226, 3305.4545999909988, 3398.2863598644312, 38158.80920595407, 38517.61482385168, 44982.77508612469, 45902.344160096596, 46442.30336544989, 7356.558606483628, 7389.371903388273, 7481.9251807482315, 7501.474896757284, 7504.174540800507, 12085.274883507018, 12104.87895121055, 12121.878781212252, 12124.333161676192, 12138.08964327679, 6664.900026499607, 6804.84317665998, 6853.280405557444, 6886.173659160932, 6980.860382792316, 4224.070704445017, 4289.849855255114, 4336.059479553904, 4355.3684715716045, 4360.694751367374, 2824.5057115004793, 2858.2997165694123, 2860.5423132298733, 2860.985695071511, 2863.6993115722967, 429.5489735777421, 436.6594056635829, 448.0255444408399, 449.53024089825556, 454.19380599436266, 569.5415190771469, 663.797541749771, 666.7166454256921, 668.4685674888475, 703.5005146346049, 8653.567321633893, 8900.243479304203, 8903.287736981027, 9076.500792456478, 9137.588808503633, 542.9429909859487, 627.9120923070774, 655.8555320964947, 681.2097966358999, 701.8105111619834, 4194.559571245037, 4328.805203765838, 4339.349097635317, 4403.405540252089, 4546.52261512543, 59647.70176149091, 59772.0, 60052.39947600556, 60181.69909150426, 60228.698856506315, 51761.0, 53354.73322633362, 53552.0, 53760.73119634377, 53907.0, 43235.56764432316, 43351.0, 48443.757781210865, 48493.27260091101, 49086.0, 8813.2949364052, 8826.779330516532, 8830.735077947671, 9040.819183616422, 9041.965557749454, 35621.82189089038, 35687.46468803022, 36260.81869590635, 36422.27155456929, 36474.27051459009, 43817.56182438135, 50621.0, 50995.49004510056, 51145.0, 51500.22749658833, 7709.306162445182, 7729.845403092019, 7772.45592808498, 7838.216178382117, 7945.8808117879435, 11454.427278635869, 11534.0, 11607.593734219261, 11697.06423486136, 12139.08956828259, 11679.06567474583, 11699.2980421175, 11737.941310293394, 11789.469473873867, 11830.467628956545, 11206.439678015904, 11398.715032124263, 11527.193096483501, 11681.240719353214, 11723.589674361356, 11644.475998580254, 11888.702782430508, 11921.82117268259, 11957.940210298893, 11994.100442467025, 9744.561013823135, 10007.849882251627, 10322.12261957742, 10444.738881528023, 10618.1505479563, 9556.331056825955, 10169.949150254497, 10297.53661085238, 10314.381137131797, 10476.214283928888]}, "summary": {"lowerIsBetter": false, "suite": 6787.917000860197, "subtests": {"jquery.html": {"lowerIsBetter": false, "filtered": 8006.453017386898, "unit": "ms", "value": 8006.453017386898}, "dojo.html": {"lowerIsBetter": false, "filtered": 5394.590220912972, "unit": "ms", "value": 5394.590220912972}, "mootools.html": {"lowerIsBetter": false, "filtered": 4250.534341337509, "unit": "ms", "value": 4250.534341337509}, "ext.html": {"lowerIsBetter": false, "filtered": 18142.02121644331, "unit": "ms", "value": 18142.02121644331}, "prototype.html": {"lowerIsBetter": false, "filtered": 4823.959557692307, "unit": "ms", "value": 4823.959557692307}, "yui.html": {"lowerIsBetter": false, "filtered": 6087.64509046741, "unit": "ms", "value": 6087.64509046741}}}, "test_machine": {"platform": "x86_64", "osversion": "Ubuntu 12.04", "os": "linux", "name": "talos-linux64-ix-017"}, "testrun": {"date": 1447657160, "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": "45.0a1", "id": "20151115203128", "branch": "B2G-Inbound", "revision": "91245e9464943de25c76f2aacdca1b1976eabb87"}}, {"talos_counters": {}, "results": {"audio-dft": [161.0, 161.0, 160.0, 159.0, 160.0, 158.0, 161.0, 163.0, 162.0, 161.0], "ai-astar": [109.0, 112.0, 105.0, 110.0, 111.0, 112.0, 101.0, 111.0, 115.0, 111.0], "imaging-gaussian-blur": [109.0, 109.0, 110.0, 109.0, 109.0, 109.0, 109.0, 110.0, 109.0, 108.0], "audio-beat-detection": [145.0, 128.0, 159.0, 159.0, 126.0, 152.0, 159.0, 125.0, 164.0, 125.0], "json-stringify-tinderbox": [67.0, 68.0, 68.0, 68.0, 69.0, 69.0, 68.0, 69.0, 69.0, 69.0], "stanford-crypto-pbkdf2": [138.0, 148.0, 147.0, 149.0, 151.0, 138.0, 148.0, 147.0, 151.0, 137.0], "json-parse-financial": [60.0, 60.0, 59.0, 58.0, 59.0, 59.0, 59.0, 68.0, 57.0, 58.0], "stanford-crypto-sha256-iterative": [69.0, 66.0, 72.0, 68.0, 67.0, 67.0, 68.0, 68.0, 65.0, 65.0], "audio-fft": [72.0, 73.0, 86.0, 93.0, 71.0, 71.0, 73.0, 116.0, 89.0, 72.0], "imaging-darkroom": [146.0, 147.0, 146.0, 148.0, 145.0, 146.0, 146.0, 147.0, 146.0, 146.0], "stanford-crypto-ccm": [121.0, 119.0, 117.0, 115.0, 119.0, 114.0, 120.0, 121.0, 126.0, 124.0], "audio-oscillator": [91.0, 91.0, 139.0, 90.0, 90.0, 90.0, 135.0, 92.0, 91.0, 137.0], "stanford-crypto-aes": [85.0, 92.0, 84.0, 84.0, 83.0, 84.0, 84.0, 85.0, 86.0, 85.0], "imaging-desaturate": [96.0, 96.0, 96.0, 95.0, 96.0, 95.0, 96.0, 96.0, 96.0, 95.0]}, "summary": {"lowerIsBetter": true, "suite": 1497.6000000000004, "subtests": {"audio-fft": {"lowerIsBetter": true, "filtered": 81.6, "unit": "ms", "value": 81.6}, "stanford-crypto-pbkdf2": {"lowerIsBetter": true, "filtered": 145.4, "unit": "ms", "value": 145.4}, "audio-beat-detection": {"lowerIsBetter": true, "filtered": 144.2, "unit": "ms", "value": 144.2}, "stanford-crypto-ccm": {"lowerIsBetter": true, "filtered": 119.6, "unit": "ms", "value": 119.6}, "imaging-darkroom": {"lowerIsBetter": true, "filtered": 146.3, "unit": "ms", "value": 146.3}, "json-parse-financial": {"lowerIsBetter": true, "filtered": 59.7, "unit": "ms", "value": 59.7}, "audio-oscillator": {"lowerIsBetter": true, "filtered": 104.6, "unit": "ms", "value": 104.6}, "ai-astar": {"lowerIsBetter": true, "filtered": 109.7, "unit": "ms", "value": 109.7}, "audio-dft": {"lowerIsBetter": true, "filtered": 160.6, "unit": "ms", "value": 160.6}, "stanford-crypto-sha256-iterative": {"lowerIsBetter": true, "filtered": 67.5, "unit": "ms", "value": 67.5}, "json-stringify-tinderbox": {"lowerIsBetter": true, "filtered": 68.4, "unit": "ms", "value": 68.4}, "imaging-gaussian-blur": {"lowerIsBetter": true, "filtered": 109.1, "unit": "ms", "value": 109.1}, "stanford-crypto-aes": {"lowerIsBetter": true, "filtered": 85.2, "unit": "ms", "value": 85.2}, "imaging-desaturate": {"lowerIsBetter": true, "filtered": 95.7, "unit": "ms", "value": 95.7}}}, "test_machine": {"platform": "x86_64", "osversion": "Ubuntu 12.04", "os": "linux", "name": "talos-linux64-ix-017"}, "testrun": {"date": 1447657160, "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": "45.0a1", "id": "20151115203128", "branch": "B2G-Inbound", "revision": "91245e9464943de25c76f2aacdca1b1976eabb87"}}, {"talos_counters": {}, "results": {"DeltaBlue": [188.21757952192735], "Encrypt": [280.74115665356544], "NavierStokes": [4826.923076923077], "Decrypt": [5035.175879396985], "Splay": [641.8962203715568], "Richards": [170.7067258449983], "RegExp": [25820.51282051282], "Earley": [808.4074373484236], "Boyer": [12195.121951219513], "RayTrace": [1100.0]}, "summary": {"lowerIsBetter": false, "suite": 20887.91523538001, "subtests": {"DeltaBlue": {"lowerIsBetter": false, "filtered": 351.2849339999999, "unit": "score", "value": 351.2849339999999}, "Encrypt": {"lowerIsBetter": false, "filtered": 948.136722, "unit": "score", "value": 948.136722}, "NavierStokes": {"lowerIsBetter": false, "filtered": 307.4422310756973, "unit": "score", "value": 307.4422310756973}, "Decrypt": {"lowerIsBetter": false, "filtered": 52.864290419161705, "unit": "score", "value": 52.864290419161705}, "Splay": {"lowerIsBetter": false, "filtered": 126.95354391217559, "unit": "score", "value": 126.95354391217559}, "RegExp": {"lowerIsBetter": false, "filtered": 35.28144488579943, "unit": "score", "value": 35.28144488579943}, "Richards": {"lowerIsBetter": false, "filtered": 206.79911599999994, "unit": "score", "value": 206.79911599999994}, "Earley": {"lowerIsBetter": false, "filtered": 824.4147309999997, "unit": "score", "value": 824.4147309999997}, "Boyer": {"lowerIsBetter": false, "filtered": 54.64996600000001, "unit": "score", "value": 54.64996600000001}, "RayTrace": {"lowerIsBetter": false, "filtered": 672.7172727272729, "unit": "score", "value": 672.7172727272729}}}, "test_machine": {"platform": "x86_64", "osversion": "Ubuntu 12.04", "os": "linux", "name": "talos-linux64-ix-017"}, "testrun": {"date": 1447657160, "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": "45.0a1", "id": "20151115203128", "branch": "B2G-Inbound", "revision": "91245e9464943de25c76f2aacdca1b1976eabb87"}}] 23:19:30 INFO - RETURN: dromaeo_css: 6787.92 23:19:30 INFO - RETURN: kraken: 1497.60 23:19:30 INFO - RETURN: v8_7: 20887.92 23:19:30 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,201,35]]", "result": "20887.92"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,201,35]]", "result": "1497.60"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,201,35]]", "result": "6787.92"}}} 23:19:30 INFO - Return code: 0 23:19:30 INFO - # TBPL SUCCESS # 23:19:30 INFO - Running post-action listener: _resource_record_post_action 23:19:30 INFO - Running post-run listener: _resource_record_post_run 23:19:31 INFO - Total resource usage - Wall time: 1224s; CPU: 13.0%; Read bytes: 4096; Write bytes: 511221760; Read time: 12; Write time: 502500 23:19:31 INFO - install - Wall time: 15s; CPU: 15.0%; Read bytes: 0; Write bytes: 233046016; Read time: 0; Write time: 337928 23:19:31 INFO - run-tests - Wall time: 1210s; CPU: 13.0%; Read bytes: 4096; Write bytes: 273465344; Read time: 12; Write time: 164308 23:19:31 INFO - Running post-run listener: _upload_blobber_files 23:19:31 INFO - Blob upload gear active. 23:19:31 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 23:19:31 INFO - Copying logs to upload dir... 23:19:31 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1255.325150 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 55 secs) (at 2015-11-15 23:19:31.384693) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-15 23:19:31.388321) ========= 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=6587686cb2da90a5f91b3170000001be-1447655857.723338-17557532 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/PAz6lGe7SA-GgW1my1TeGw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.010001 build_url: 'https://queue.taskcluster.net/v1/task/PAz6lGe7SA-GgW1my1TeGw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2' ========= master_lag: 0.04 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-15 23:19:31.440011) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-15 23:19:31.440367) ========= 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=6587686cb2da90a5f91b3170000001be-1447655857.723338-17557532 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004559 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-15 23:19:31.490192) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-15 23:19:31.490520) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-15 23:19:31.490835) ========= ========= Total master_lag: 0.22 =========