builder: b2g-inbound_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-013 starttime: 1447999104.19 results: success (0) buildid: 20151119203157 builduid: 1a06d4b542064a10a158f5185d462dd2 revision: 138cebd69d9227119e2947e4b2e2def7f6bac84f ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-11-19 21:58:24.193459) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-11-19 21:58:24.193817) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-19 21:58:24.194102) ========= 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=256b35f542ca8bede9e27f1f00000291-1447998187.971045-1073784541 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006787 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.03 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-19 21:58:24.228509) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-19 21:58:24.228809) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-19 21:58:24.253541) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-19 21:58:24.253794) ========= 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=256b35f542ca8bede9e27f1f00000291-1447998187.971045-1073784541 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004652 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-19 21:58:24.306589) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-19 21:58:24.306873) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-19 21:58:24.307238) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-19 21:58:24.307524) ========= 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=256b35f542ca8bede9e27f1f00000291-1447998187.971045-1073784541 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-11-19 21:58:24-- 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% 224M=0s 2015-11-19 21:58:24 (224 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.107952 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-19 21:58:24.434313) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-19 21:58:24.434631) ========= 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=256b35f542ca8bede9e27f1f00000291-1447998187.971045-1073784541 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018235 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-19 21:58:24.483594) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-19 21:58:24.483922) ========= bash -c 'python archiver_client.py mozharness --repo integration/b2g-inbound --rev 138cebd69d9227119e2947e4b2e2def7f6bac84f --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 138cebd69d9227119e2947e4b2e2def7f6bac84f --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=256b35f542ca8bede9e27f1f00000291-1447998187.971045-1073784541 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-11-19 21:58:25,019 truncating revision to first 12 chars 2015-11-19 21:58:25,020 Setting DEBUG logging. 2015-11-19 21:58:25,020 attempt 1/10 2015-11-19 21:58:25,020 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/b2g-inbound/138cebd69d92?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-11-19 21:58:25,279 unpacking tar archive at: b2g-inbound-138cebd69d92/testing/mozharness/ program finished with exit code 0 elapsedTime=0.538390 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-19 21:58:25.035229) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-19 21:58:25.035626) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-19 21:58:25.046794) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-19 21:58:25.047031) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-19 21:58:25.047445) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 22 mins, 51 secs) (at 2015-11-19 21:58:25.047722) ========= /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=256b35f542ca8bede9e27f1f00000291-1447998187.971045-1073784541 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 21:58:25 INFO - MultiFileLogger online at 20151119 21:58:25 in /builds/slave/test-pgo 21:58:25 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 21:58:25 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 21:58:25 INFO - {'append_to_log': False, 21:58:25 INFO - 'base_work_dir': '/builds/slave/test-pgo', 21:58:25 INFO - 'blob_upload_branch': 'B2G-Inbound', 21:58:25 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 21:58:25 INFO - 'branch': 'B2G-Inbound', 21:58:25 INFO - 'buildbot_json_path': 'buildprops.json', 21:58:25 INFO - 'config_files': ('talos/linux_config.py',), 21:58:25 INFO - 'default_actions': ('clobber', 21:58:25 INFO - 'read-buildbot-config', 21:58:25 INFO - 'download-and-extract', 21:58:25 INFO - 'populate-webroot', 21:58:25 INFO - 'create-virtualenv', 21:58:25 INFO - 'install', 21:58:25 INFO - 'run-tests'), 21:58:25 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 21:58:25 INFO - 'download_minidump_stackwalk': True, 21:58:25 INFO - 'download_symbols': 'ondemand', 21:58:25 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 21:58:25 INFO - 'tooltool.py': '/tools/tooltool.py', 21:58:25 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 21:58:25 INFO - '/tools/misc-python/virtualenv.py')}, 21:58:25 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 21:58:25 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 21:58:25 INFO - 'installer_path': 'installer.exe', 21:58:25 INFO - 'log_level': 'info', 21:58:25 INFO - 'log_name': 'talos', 21:58:25 INFO - 'log_to_console': True, 21:58:25 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 21:58:25 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 21:58:25 INFO - 'opt_config_files': (), 21:58:25 INFO - 'pip_index': False, 21:58:25 INFO - 'sps_profile': False, 21:58:25 INFO - 'sps_profile_interval': 0, 21:58:25 INFO - 'suite': 'dromaeojs', 21:58:25 INFO - 'system_bits': '64', 21:58:25 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 21:58:25 INFO - 'title': 'talos-linux64-ix-013', 21:58:25 INFO - 'tooltool_cache': '/builds/tooltool_cache', 21:58:25 INFO - 'use_talos_json': True, 21:58:25 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 21:58:25 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 21:58:25 INFO - 'work_dir': 'build'} 21:58:25 INFO - ##### 21:58:25 INFO - ##### Running clobber step. 21:58:25 INFO - ##### 21:58:25 INFO - Running pre-action listener: _resource_record_pre_action 21:58:25 INFO - Running main action method: clobber 21:58:25 INFO - rmtree: /builds/slave/test-pgo/build 21:58:25 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 21:58:26 INFO - Running post-action listener: _resource_record_post_action 21:58:26 INFO - ##### 21:58:26 INFO - ##### Running read-buildbot-config step. 21:58:26 INFO - ##### 21:58:26 INFO - Running pre-action listener: _resource_record_pre_action 21:58:26 INFO - Running main action method: read_buildbot_config 21:58:26 INFO - Using buildbot properties: 21:58:26 INFO - { 21:58:26 INFO - "properties": { 21:58:26 INFO - "buildnumber": 982, 21:58:26 INFO - "product": "firefox", 21:58:26 INFO - "script_repo_revision": "production", 21:58:26 INFO - "builddir": "b2g-inbound_ubuntu64_hw_test-dromaeojs", 21:58:26 INFO - "repository": "", 21:58:26 INFO - "buildername": "Ubuntu HW 12.04 x64 b2g-inbound pgo talos dromaeojs", 21:58:26 INFO - "buildid": "20151119203157", 21:58:26 INFO - "slavename": "talos-linux64-ix-013", 21:58:26 INFO - "pgo_build": "True", 21:58:26 INFO - "basedir": "/builds/slave/test-pgo", 21:58:26 INFO - "project": "", 21:58:26 INFO - "platform": "ubuntu64_hw", 21:58:26 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 21:58:26 INFO - "slavebuilddir": "test", 21:58:26 INFO - "scheduler": "tests-b2g-inbound-linux64-pgo-talos", 21:58:26 INFO - "branch": "b2g-inbound", 21:58:26 INFO - "repo_path": "integration/b2g-inbound", 21:58:26 INFO - "stage_platform": "linux64-pgo", 21:58:26 INFO - "builduid": "1a06d4b542064a10a158f5185d462dd2", 21:58:26 INFO - "revision": "138cebd69d9227119e2947e4b2e2def7f6bac84f" 21:58:26 INFO - }, 21:58:26 INFO - "sourcestamp": { 21:58:26 INFO - "repository": "", 21:58:26 INFO - "hasPatch": false, 21:58:26 INFO - "project": "", 21:58:26 INFO - "branch": "b2g-inbound-linux64-pgo-talos", 21:58:26 INFO - "changes": [ 21:58:26 INFO - { 21:58:26 INFO - "category": null, 21:58:26 INFO - "files": [ 21:58:26 INFO - { 21:58:26 INFO - "url": null, 21:58:26 INFO - "name": "https://queue.taskcluster.net/v1/task/Z2BrdRaaTa-ne8G6NhFIkQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2" 21:58:26 INFO - } 21:58:26 INFO - ], 21:58:26 INFO - "repository": "", 21:58:26 INFO - "rev": "138cebd69d9227119e2947e4b2e2def7f6bac84f", 21:58:26 INFO - "who": "sendchange", 21:58:26 INFO - "when": 1447999084, 21:58:26 INFO - "number": 6686954, 21:58:26 INFO - "comments": "", 21:58:26 INFO - "project": "", 21:58:26 INFO - "at": "Thu 19 Nov 2015 21:58:04", 21:58:26 INFO - "branch": "b2g-inbound-linux64-pgo-talos", 21:58:26 INFO - "revlink": "", 21:58:26 INFO - "properties": [ 21:58:26 INFO - [ 21:58:26 INFO - "buildid", 21:58:26 INFO - "20151119203157", 21:58:26 INFO - "Change" 21:58:26 INFO - ], 21:58:26 INFO - [ 21:58:26 INFO - "builduid", 21:58:26 INFO - "1a06d4b542064a10a158f5185d462dd2", 21:58:26 INFO - "Change" 21:58:26 INFO - ], 21:58:26 INFO - [ 21:58:26 INFO - "pgo_build", 21:58:26 INFO - "True", 21:58:26 INFO - "Change" 21:58:26 INFO - ] 21:58:26 INFO - ], 21:58:26 INFO - "revision": "138cebd69d9227119e2947e4b2e2def7f6bac84f" 21:58:26 INFO - } 21:58:26 INFO - ], 21:58:26 INFO - "revision": "138cebd69d9227119e2947e4b2e2def7f6bac84f" 21:58:26 INFO - } 21:58:26 INFO - } 21:58:26 INFO - Found installer url https://queue.taskcluster.net/v1/task/Z2BrdRaaTa-ne8G6NhFIkQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2. 21:58:26 INFO - Running post-action listener: _resource_record_post_action 21:58:26 INFO - ##### 21:58:26 INFO - ##### Running download-and-extract step. 21:58:26 INFO - ##### 21:58:26 INFO - Running pre-action listener: _resource_record_pre_action 21:58:26 INFO - Running main action method: download_and_extract 21:58:26 INFO - mkdir: /builds/slave/test-pgo/build/tests 21:58:26 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')]} 21:58:26 INFO - https://queue.taskcluster.net/v1/task/Z2BrdRaaTa-ne8G6NhFIkQ/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 21:58:26 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Z2BrdRaaTa-ne8G6NhFIkQ/artifacts/public/build/test_packages.json 21:58:26 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Z2BrdRaaTa-ne8G6NhFIkQ/artifacts/public/build/test_packages.json 21:58:26 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Z2BrdRaaTa-ne8G6NhFIkQ/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 21:58:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Z2BrdRaaTa-ne8G6NhFIkQ/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 21:58:27 INFO - Downloaded 1302 bytes. 21:58:27 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 21:58:27 INFO - Using the following test package requirements: 21:58:27 INFO - {u'common': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 21:58:27 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 21:58:27 INFO - u'firefox-45.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 21:58:27 INFO - u'jittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 21:58:27 INFO - u'jsshell-linux-x86_64.zip'], 21:58:27 INFO - u'mochitest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 21:58:27 INFO - u'firefox-45.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 21:58:27 INFO - u'mozbase': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 21:58:27 INFO - u'reftest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 21:58:27 INFO - u'firefox-45.0a1.en-US.linux-x86_64.reftest.tests.zip'], 21:58:27 INFO - u'talos': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 21:58:27 INFO - u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'], 21:58:27 INFO - u'web-platform': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 21:58:27 INFO - u'firefox-45.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 21:58:27 INFO - u'webapprt': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 21:58:27 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 21:58:27 INFO - u'firefox-45.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 21:58:27 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 21:58:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:58:27 INFO - https://queue.taskcluster.net/v1/task/Z2BrdRaaTa-ne8G6NhFIkQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 21:58:27 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Z2BrdRaaTa-ne8G6NhFIkQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 21:58:27 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Z2BrdRaaTa-ne8G6NhFIkQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 21:58:27 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Z2BrdRaaTa-ne8G6NhFIkQ/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 21:58:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Z2BrdRaaTa-ne8G6NhFIkQ/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 21:58:28 INFO - Downloaded 22520909 bytes. 21:58:28 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 21:58:28 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 21:58:28 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 21:58:31 INFO - Return code: 0 21:58:31 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 21:58:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:58:31 INFO - https://queue.taskcluster.net/v1/task/Z2BrdRaaTa-ne8G6NhFIkQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 21:58:31 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Z2BrdRaaTa-ne8G6NhFIkQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 21:58:31 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Z2BrdRaaTa-ne8G6NhFIkQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 21:58:31 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Z2BrdRaaTa-ne8G6NhFIkQ/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 21:58:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Z2BrdRaaTa-ne8G6NhFIkQ/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 21:58:40 INFO - Downloaded 22520909 bytes. 21:58:40 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 21:58:40 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 21:58:40 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 21:58:41 INFO - Return code: 0 21: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')]} 21:58:41 INFO - https://queue.taskcluster.net/v1/task/Z2BrdRaaTa-ne8G6NhFIkQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 21:58:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Z2BrdRaaTa-ne8G6NhFIkQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 21:58:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Z2BrdRaaTa-ne8G6NhFIkQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 21:58:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Z2BrdRaaTa-ne8G6NhFIkQ/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 21:58:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Z2BrdRaaTa-ne8G6NhFIkQ/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 21:58:44 INFO - Downloaded 11130997 bytes. 21: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 21:58:44 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 21: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 21:58:44 INFO - Return code: 0 21: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')]} 21:58:44 INFO - https://queue.taskcluster.net/v1/task/Z2BrdRaaTa-ne8G6NhFIkQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 21:58:44 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Z2BrdRaaTa-ne8G6NhFIkQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 21:58:44 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Z2BrdRaaTa-ne8G6NhFIkQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 21:58:44 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Z2BrdRaaTa-ne8G6NhFIkQ/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 21:58:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Z2BrdRaaTa-ne8G6NhFIkQ/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 21:58:50 INFO - Downloaded 57347003 bytes. 21:58:50 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Z2BrdRaaTa-ne8G6NhFIkQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 21:58:50 INFO - mkdir: /builds/slave/test-pgo/properties 21:58:50 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 21:58:50 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 21:58:50 INFO - Contents: 21:58:50 INFO - build_url:https://queue.taskcluster.net/v1/task/Z2BrdRaaTa-ne8G6NhFIkQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 21:58:50 INFO - Running post-action listener: _resource_record_post_action 21:58:50 INFO - Running post-action listener: set_extra_try_arguments 21:58:50 INFO - ##### 21:58:50 INFO - ##### Running populate-webroot step. 21:58:50 INFO - ##### 21:58:50 INFO - Running pre-action listener: _resource_record_pre_action 21:58:50 INFO - Running main action method: populate_webroot 21:58:50 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 21:58:50 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 21:58:50 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 21:58:50 INFO - '../fennec_ids.txt'], 21:58:50 INFO - 'tests': ['tcheck2']}, 21:58:50 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 21:58:50 INFO - '--tppagecycles', 21:58:50 INFO - '7'], 21:58:50 INFO - 'tests': ['tsvgm']}}, 21:58:50 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 21:58:50 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 21:58:50 INFO - 'tests': ['tresize', 'tcanvasmark']}, 21:58:50 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 21:58:50 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 21:58:50 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 21:58:50 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:58:50 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 21:58:50 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:58:50 INFO - 'talos_options': ['--e10s'], 21:58:50 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 21:58:50 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:58:50 INFO - 'tests': ['damp', 'tps']}, 21:58:50 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:58:50 INFO - 'talos_options': ['--e10s'], 21:58:50 INFO - 'tests': ['damp', 'tps']}, 21:58:50 INFO - 'g3': {'tests': ['dromaeo_dom']}, 21:58:50 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 21:58:50 INFO - 'other': {'tests': ['a11yr', 21:58:50 INFO - 'ts_paint', 21:58:50 INFO - 'tpaint', 21:58:50 INFO - 'sessionrestore', 21:58:50 INFO - 'sessionrestore_no_auto_restore']}, 21:58:50 INFO - 'other-e10s': {'talos_options': ['--e10s'], 21:58:50 INFO - 'tests': ['a11yr', 21:58:50 INFO - 'ts_paint', 21:58:50 INFO - 'tpaint', 21:58:50 INFO - 'sessionrestore', 21:58:50 INFO - 'sessionrestore_no_auto_restore']}, 21:58:50 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 21:58:50 INFO - 'tests': ['a11yr', 21:58:50 INFO - 'ts_paint', 21:58:50 INFO - 'tpaint', 21:58:50 INFO - 'sessionrestore', 21:58:50 INFO - 'sessionrestore_no_auto_restore']}, 21:58:50 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 21:58:50 INFO - 'tests': ['a11yr', 21:58:50 INFO - 'ts_paint', 21:58:50 INFO - 'tpaint', 21:58:50 INFO - 'sessionrestore', 21:58:50 INFO - 'sessionrestore_no_auto_restore']}, 21:58:50 INFO - 'other_l64': {'tests': ['a11yr', 21:58:50 INFO - 'ts_paint', 21:58:50 INFO - 'tpaint', 21:58:50 INFO - 'sessionrestore', 21:58:50 INFO - 'sessionrestore_no_auto_restore']}, 21:58:50 INFO - 'other_nol64': {'tests': ['a11yr', 21:58:50 INFO - 'ts_paint', 21:58:50 INFO - 'tpaint', 21:58:50 INFO - 'sessionrestore', 21:58:50 INFO - 'sessionrestore_no_auto_restore']}, 21:58:50 INFO - 'svgr': {'tests': ['tsvgx', 21:58:50 INFO - 'tsvgr_opacity', 21:58:50 INFO - 'tart', 21:58:50 INFO - 'tscrollx', 21:58:50 INFO - 'cart']}, 21:58:50 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 21:58:50 INFO - 'tests': ['tsvgx', 21:58:50 INFO - 'tsvgr_opacity', 21:58:50 INFO - 'tart', 21:58:50 INFO - 'tscrollx', 21:58:50 INFO - 'cart']}, 21:58:50 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:58:50 INFO - 'tests': ['tp5o']}, 21:58:50 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:58:50 INFO - 'talos_options': ['--e10s'], 21:58:50 INFO - 'tests': ['tp5o']}, 21:58:50 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:58:50 INFO - 'talos_options': ['--xperf_path', 21:58:50 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 21:58:50 INFO - 'tests': ['tp5n']}, 21:58:50 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:58:50 INFO - 'talos_options': ['--e10s', 21:58:50 INFO - '--xperf_path', 21:58:50 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 21:58:50 INFO - 'tests': ['tp5n']}}, 21:58:50 INFO - 'talos.zip': {'path': '', 21:58:50 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 21:58:50 INFO - Running post-action listener: _resource_record_post_action 21:58:50 INFO - ##### 21:58:50 INFO - ##### Running create-virtualenv step. 21:58:50 INFO - ##### 21:58:50 INFO - Running pre-action listener: _resource_record_pre_action 21:58:50 INFO - Running main action method: create_virtualenv 21:58:50 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 21:58:50 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 21:58:50 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 21:58:51 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 21:58:51 INFO - Using real prefix '/usr' 21:58:51 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 21:58:51 INFO - Installing distribute.............................................................................................................................................................................................done. 21:58:53 INFO - Installing pip.................done. 21:58:53 INFO - Return code: 0 21:58:53 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 21: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')]} 21:58:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:58:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21: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')]} 21:58:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:58:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe36a8d0c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21496c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x220a6e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2240a90>, '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 0x2292f70>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22932e0>, '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': '256b35f542ca8bede9e27f1f00000291-1447998187.971045-1073784541', '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 21: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', 'pip>=1.5'] in /builds/slave/test-pgo/build 21: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 pip>=1.5 21:58:53 INFO - Using env: {'DISPLAY': ':0', 21:58:53 INFO - 'HOME': '/home/cltbld', 21:58:53 INFO - 'LANG': 'en_US.UTF-8', 21:58:53 INFO - 'LANGUAGE': 'en_US:en', 21:58:53 INFO - 'LOGNAME': 'cltbld', 21:58:53 INFO - 'MAIL': '/var/mail/cltbld', 21:58:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:58:53 INFO - 'MOZ_NO_REMOTE': '1', 21:58:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:58:53 INFO - 'NO_EM_RESTART': '1', 21:58:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:58:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 21:58:53 INFO - 'PWD': '/builds/slave/test-pgo', 21:58:53 INFO - 'SHELL': '/bin/bash', 21:58:53 INFO - 'SHLVL': '1', 21:58:53 INFO - 'TERM': 'linux', 21:58:53 INFO - 'TMOUT': '86400', 21:58:53 INFO - 'USER': 'cltbld', 21:58:53 INFO - 'XDG_SESSION_COOKIE': '256b35f542ca8bede9e27f1f00000291-1447998187.971045-1073784541', 21:58:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:58:53 INFO - '_': '/tools/buildbot/bin/python'} 21:58:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:58:53 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 21:58:53 INFO - Cleaning up... 21:58:53 INFO - Return code: 0 21:58:53 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 21: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')]} 21:58:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:58:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21: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')]} 21:58:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:58:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21: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', '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 0x7fe36a8d0c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21496c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x220a6e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2240a90>, '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 0x2292f70>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22932e0>, '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': '256b35f542ca8bede9e27f1f00000291-1447998187.971045-1073784541', '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 21: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', 'psutil>=0.7.1'] in /builds/slave/test-pgo/build 21: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 psutil>=0.7.1 21:58:53 INFO - Using env: {'DISPLAY': ':0', 21:58:53 INFO - 'HOME': '/home/cltbld', 21:58:53 INFO - 'LANG': 'en_US.UTF-8', 21:58:53 INFO - 'LANGUAGE': 'en_US:en', 21:58:53 INFO - 'LOGNAME': 'cltbld', 21:58:53 INFO - 'MAIL': '/var/mail/cltbld', 21:58:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:58:53 INFO - 'MOZ_NO_REMOTE': '1', 21:58:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:58:53 INFO - 'NO_EM_RESTART': '1', 21:58:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:58:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 21:58:53 INFO - 'PWD': '/builds/slave/test-pgo', 21:58:53 INFO - 'SHELL': '/bin/bash', 21:58:53 INFO - 'SHLVL': '1', 21:58:53 INFO - 'TERM': 'linux', 21:58:53 INFO - 'TMOUT': '86400', 21:58:53 INFO - 'USER': 'cltbld', 21:58:53 INFO - 'XDG_SESSION_COOKIE': '256b35f542ca8bede9e27f1f00000291-1447998187.971045-1073784541', 21:58:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:58:53 INFO - '_': '/tools/buildbot/bin/python'} 21:58:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:58:53 INFO - Downloading/unpacking psutil>=0.7.1 21: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 21: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 21: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 21: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 21: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 21: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 21:58:55 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 21:58:55 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 21:58:55 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 21:58:55 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 21:58:55 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 21:58:55 INFO - Installing collected packages: psutil 21:58:55 INFO - Running setup.py install for psutil 21:58:55 INFO - building 'psutil._psutil_linux' extension 21:58:55 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 21:58:55 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 21:58:55 INFO - building 'psutil._psutil_posix' extension 21:58:55 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 21:58:56 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 21:58:56 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 21:58:56 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 21:58:56 INFO - Successfully installed psutil 21:58:56 INFO - Cleaning up... 21:58:56 INFO - Return code: 0 21:58:56 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 21:58:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:58:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:58:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:58:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:58:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:58:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:58:56 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 0x7fe36a8d0c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21496c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x220a6e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2240a90>, '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 0x2292f70>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22932e0>, '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': '256b35f542ca8bede9e27f1f00000291-1447998187.971045-1073784541', '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 21:58:56 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 21:58:56 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 21:58:56 INFO - Using env: {'DISPLAY': ':0', 21:58:56 INFO - 'HOME': '/home/cltbld', 21:58:56 INFO - 'LANG': 'en_US.UTF-8', 21:58:56 INFO - 'LANGUAGE': 'en_US:en', 21:58:56 INFO - 'LOGNAME': 'cltbld', 21:58:56 INFO - 'MAIL': '/var/mail/cltbld', 21:58:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:58:56 INFO - 'MOZ_NO_REMOTE': '1', 21:58:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:58:56 INFO - 'NO_EM_RESTART': '1', 21:58:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:58:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 21:58:56 INFO - 'PWD': '/builds/slave/test-pgo', 21:58:56 INFO - 'SHELL': '/bin/bash', 21:58:56 INFO - 'SHLVL': '1', 21:58:56 INFO - 'TERM': 'linux', 21:58:56 INFO - 'TMOUT': '86400', 21:58:56 INFO - 'USER': 'cltbld', 21:58:56 INFO - 'XDG_SESSION_COOKIE': '256b35f542ca8bede9e27f1f00000291-1447998187.971045-1073784541', 21:58:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:58:56 INFO - '_': '/tools/buildbot/bin/python'} 21:58:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:58:56 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 21:58:56 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 21:58:56 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 21:58:56 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 21:58:56 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 21:58:56 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 21:58:56 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 21:58:58 INFO - Downloading mozsystemmonitor-0.0.tar.gz 21:58:58 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 21:58:58 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 21:58:58 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 21:58:58 INFO - Installing collected packages: mozsystemmonitor 21:58:58 INFO - Running setup.py install for mozsystemmonitor 21:58:58 INFO - Successfully installed mozsystemmonitor 21:58:58 INFO - Cleaning up... 21:58:58 INFO - Return code: 0 21:58:58 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 21: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')]} 21:58:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:58:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21: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')]} 21:58:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:58:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:58:58 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 0x7fe36a8d0c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21496c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x220a6e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2240a90>, '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 0x2292f70>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22932e0>, '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': '256b35f542ca8bede9e27f1f00000291-1447998187.971045-1073784541', '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 21:58:58 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 21:58:58 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 21:58:58 INFO - Using env: {'DISPLAY': ':0', 21:58:58 INFO - 'HOME': '/home/cltbld', 21:58:58 INFO - 'LANG': 'en_US.UTF-8', 21:58:58 INFO - 'LANGUAGE': 'en_US:en', 21:58:58 INFO - 'LOGNAME': 'cltbld', 21:58:58 INFO - 'MAIL': '/var/mail/cltbld', 21:58:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:58:58 INFO - 'MOZ_NO_REMOTE': '1', 21:58:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:58:58 INFO - 'NO_EM_RESTART': '1', 21:58:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:58:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 21:58:58 INFO - 'PWD': '/builds/slave/test-pgo', 21:58:58 INFO - 'SHELL': '/bin/bash', 21:58:58 INFO - 'SHLVL': '1', 21:58:58 INFO - 'TERM': 'linux', 21:58:58 INFO - 'TMOUT': '86400', 21:58:58 INFO - 'USER': 'cltbld', 21:58:58 INFO - 'XDG_SESSION_COOKIE': '256b35f542ca8bede9e27f1f00000291-1447998187.971045-1073784541', 21:58:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:58:58 INFO - '_': '/tools/buildbot/bin/python'} 21:58:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:58:58 INFO - Downloading/unpacking blobuploader==1.2.4 21:58:58 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 21:58:58 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 21:58:58 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 21:58:58 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 21:58:58 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 21:58:58 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 21:59:00 INFO - Downloading blobuploader-1.2.4.tar.gz 21:59:00 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 21:59:00 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 21:59:00 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 21:59:00 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 21:59:00 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 21:59:00 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 21:59:00 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 21:59:00 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 21:59:00 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 21:59:00 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 21:59:00 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 21:59:00 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 21:59:00 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 21:59:00 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 21:59:00 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 21:59:00 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 21:59:00 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 21:59:00 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 21:59:00 INFO - Downloading docopt-0.6.1.tar.gz 21:59:00 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 21:59:00 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 21:59:00 INFO - Installing collected packages: blobuploader, requests, docopt 21:59:00 INFO - Running setup.py install for blobuploader 21:59:00 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 21:59:00 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 21:59:00 INFO - Running setup.py install for requests 21:59:01 INFO - Running setup.py install for docopt 21:59:01 INFO - Successfully installed blobuploader requests docopt 21:59:01 INFO - Cleaning up... 21:59:01 INFO - Return code: 0 21:59:01 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 21: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')]} 21:59:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:59:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21: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')]} 21:59:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:59:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:59:01 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 0x7fe36a8d0c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21496c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x220a6e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2240a90>, '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 0x2292f70>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22932e0>, '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': '256b35f542ca8bede9e27f1f00000291-1447998187.971045-1073784541', '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 21:59:01 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 21:59:01 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 21:59:01 INFO - Using env: {'DISPLAY': ':0', 21:59:01 INFO - 'HOME': '/home/cltbld', 21:59:01 INFO - 'LANG': 'en_US.UTF-8', 21:59:01 INFO - 'LANGUAGE': 'en_US:en', 21:59:01 INFO - 'LOGNAME': 'cltbld', 21:59:01 INFO - 'MAIL': '/var/mail/cltbld', 21:59:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:59:01 INFO - 'MOZ_NO_REMOTE': '1', 21:59:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:59:01 INFO - 'NO_EM_RESTART': '1', 21:59:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:59:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 21:59:01 INFO - 'PWD': '/builds/slave/test-pgo', 21:59:01 INFO - 'SHELL': '/bin/bash', 21:59:01 INFO - 'SHLVL': '1', 21:59:01 INFO - 'TERM': 'linux', 21:59:01 INFO - 'TMOUT': '86400', 21:59:01 INFO - 'USER': 'cltbld', 21:59:01 INFO - 'XDG_SESSION_COOKIE': '256b35f542ca8bede9e27f1f00000291-1447998187.971045-1073784541', 21:59:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:59:01 INFO - '_': '/tools/buildbot/bin/python'} 21:59:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:59:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 21:59:01 INFO - Running setup.py (path:/tmp/pip-ndcDE9-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 21:59:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 21:59:01 INFO - Running setup.py (path:/tmp/pip-1VF55Y-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 21:59:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 21:59:01 INFO - Running setup.py (path:/tmp/pip-KQc0eP-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 21:59:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 21:59:01 INFO - Running setup.py (path:/tmp/pip-lZQSqZ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 21:59:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 21:59:01 INFO - Running setup.py (path:/tmp/pip-wJY5Fl-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 21:59:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 21:59:02 INFO - Running setup.py (path:/tmp/pip-HvUIRJ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 21:59:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 21:59:02 INFO - Running setup.py (path:/tmp/pip-K_rfiI-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 21:59:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 21:59:02 INFO - Running setup.py (path:/tmp/pip-1cA2H3-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 21:59:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 21:59:02 INFO - Running setup.py (path:/tmp/pip-FDT_5J-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 21:59:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 21:59:02 INFO - Running setup.py (path:/tmp/pip-XBymLH-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 21:59:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 21:59:02 INFO - Running setup.py (path:/tmp/pip-AFPKlv-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 21:59:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 21:59:02 INFO - Running setup.py (path:/tmp/pip-_QAcJc-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 21:59:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 21:59:02 INFO - Running setup.py (path:/tmp/pip-6kvBYO-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 21:59:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 21:59:02 INFO - Running setup.py (path:/tmp/pip-a0NYhE-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 21:59:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 21:59:02 INFO - Running setup.py (path:/tmp/pip-QxKmIN-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 21:59:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 21:59:02 INFO - Running setup.py (path:/tmp/pip-VvkcLH-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 21:59:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 21:59:02 INFO - Running setup.py (path:/tmp/pip-o9Ke7b-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 21:59:02 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 21:59:02 INFO - Running setup.py install for manifestparser 21:59:02 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 21:59:02 INFO - Running setup.py install for mozcrash 21:59:03 INFO - Running setup.py install for mozdebug 21:59:03 INFO - Running setup.py install for mozdevice 21:59:03 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 21:59:03 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 21:59:03 INFO - Running setup.py install for mozfile 21:59:03 INFO - Running setup.py install for mozhttpd 21:59:03 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 21:59:03 INFO - Running setup.py install for mozinfo 21:59:03 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 21:59:03 INFO - Running setup.py install for mozInstall 21:59:03 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 21:59:03 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 21:59:03 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 21:59:03 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 21:59:03 INFO - Running setup.py install for mozleak 21:59:03 INFO - Running setup.py install for mozlog 21:59:03 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 21:59:03 INFO - Running setup.py install for moznetwork 21:59:03 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 21:59:03 INFO - Running setup.py install for mozprocess 21:59:04 INFO - Running setup.py install for mozprofile 21:59:04 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 21:59:04 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 21:59:04 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 21:59:04 INFO - Running setup.py install for mozrunner 21:59:04 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 21:59:04 INFO - Running setup.py install for mozscreenshot 21:59:04 INFO - Running setup.py install for moztest 21:59:04 INFO - Running setup.py install for mozversion 21:59:04 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 21:59:04 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 21:59:04 INFO - Cleaning up... 21:59:04 INFO - Return code: 0 21:59:04 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 21:59:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:59:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:59:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:59:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:59:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:59:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:59:04 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 0x7fe36a8d0c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21496c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x220a6e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2240a90>, '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 0x2292f70>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22932e0>, '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': '256b35f542ca8bede9e27f1f00000291-1447998187.971045-1073784541', '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 21:59:04 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 21:59:04 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 21:59:04 INFO - Using env: {'DISPLAY': ':0', 21:59:04 INFO - 'HOME': '/home/cltbld', 21:59:04 INFO - 'LANG': 'en_US.UTF-8', 21:59:04 INFO - 'LANGUAGE': 'en_US:en', 21:59:04 INFO - 'LOGNAME': 'cltbld', 21:59:04 INFO - 'MAIL': '/var/mail/cltbld', 21:59:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:59:04 INFO - 'MOZ_NO_REMOTE': '1', 21:59:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:59:04 INFO - 'NO_EM_RESTART': '1', 21:59:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:59:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 21:59:04 INFO - 'PWD': '/builds/slave/test-pgo', 21:59:04 INFO - 'SHELL': '/bin/bash', 21:59:04 INFO - 'SHLVL': '1', 21:59:04 INFO - 'TERM': 'linux', 21:59:04 INFO - 'TMOUT': '86400', 21:59:04 INFO - 'USER': 'cltbld', 21:59:04 INFO - 'XDG_SESSION_COOKIE': '256b35f542ca8bede9e27f1f00000291-1447998187.971045-1073784541', 21:59:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:59:04 INFO - '_': '/tools/buildbot/bin/python'} 21:59:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:59:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 21:59:04 INFO - Running setup.py (path:/tmp/pip-VP5l0v-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 21:59:04 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 1)) 21:59:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 21:59:04 INFO - Running setup.py (path:/tmp/pip-fgXO0Y-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 21:59:05 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)) 21:59:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 21:59:05 INFO - Running setup.py (path:/tmp/pip-RhXMEp-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 21:59:05 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)) 21:59:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 21:59:05 INFO - Running setup.py (path:/tmp/pip-sj1Xfw-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 21:59:05 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)) 21:59:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 21:59:05 INFO - Running setup.py (path:/tmp/pip-y3RHrt-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 21:59:05 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)) 21:59:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 21:59:05 INFO - Running setup.py (path:/tmp/pip-LKLnJl-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 21:59:05 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)) 21:59:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 21:59:05 INFO - Running setup.py (path:/tmp/pip-L7pzuH-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 21:59:05 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)) 21:59:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 21:59:05 INFO - Running setup.py (path:/tmp/pip-EYgKnt-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 21:59:05 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)) 21:59:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 21:59:05 INFO - Running setup.py (path:/tmp/pip-tPFbvL-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 21:59:05 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)) 21:59:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 21:59:05 INFO - Running setup.py (path:/tmp/pip-LbapbZ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 21:59:05 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)) 21:59:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 21:59:05 INFO - Running setup.py (path:/tmp/pip-qRs84n-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 21:59:05 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)) 21:59:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 21:59:05 INFO - Running setup.py (path:/tmp/pip-P72StT-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 21:59:05 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)) 21:59:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 21:59:05 INFO - Running setup.py (path:/tmp/pip-d2fDvI-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 21:59:05 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)) 21:59:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 21:59:05 INFO - Running setup.py (path:/tmp/pip-1zSjiQ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 21:59:05 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)) 21:59:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 21:59:05 INFO - Running setup.py (path:/tmp/pip-OkKcld-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 21:59:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 15)) 21:59:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 21:59:05 INFO - Running setup.py (path:/tmp/pip-unnhVx-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 21:59:06 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)) 21:59:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 21:59:06 INFO - Running setup.py (path:/tmp/pip-Lrm7SR-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 21:59:06 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)) 21:59:06 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)) 21:59:06 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)) 21:59:06 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)) 21:59:06 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)) 21:59:06 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)) 21:59:06 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.0->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 21:59:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:59:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:59:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:59:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:59:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:59:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:59:07 INFO - Downloading blessings-1.5.1.tar.gz 21:59:07 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 21:59:07 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 21:59:07 INFO - Installing collected packages: blessings 21:59:07 INFO - Running setup.py install for blessings 21:59:07 INFO - Successfully installed blessings 21:59:07 INFO - Cleaning up... 21:59:09 INFO - Return code: 0 21:59:09 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 21:59:09 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 21:59:09 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 21:59:09 INFO - Reading from file tmpfile_stdout 21:59:09 INFO - Current package versions: 21:59:09 INFO - argparse == 1.2.1 21:59:09 INFO - blessings == 1.5.1 21:59:09 INFO - blobuploader == 1.2.4 21:59:09 INFO - docopt == 0.6.1 21:59:09 INFO - manifestparser == 1.1 21:59:09 INFO - mozInstall == 1.12 21:59:09 INFO - mozcrash == 0.16 21:59:09 INFO - mozdebug == 0.1 21:59:09 INFO - mozdevice == 0.47 21:59:09 INFO - mozfile == 1.2 21:59:09 INFO - mozhttpd == 0.7 21:59:09 INFO - mozinfo == 0.9 21:59:09 INFO - mozleak == 0.1 21:59:09 INFO - mozlog == 3.0 21:59:09 INFO - moznetwork == 0.27 21:59:09 INFO - mozprocess == 0.22 21:59:09 INFO - mozprofile == 0.27 21:59:09 INFO - mozrunner == 6.11 21:59:09 INFO - mozscreenshot == 0.1 21:59:09 INFO - mozsystemmonitor == 0.0 21:59:09 INFO - moztest == 0.7 21:59:09 INFO - mozversion == 1.4 21:59:09 INFO - psutil == 3.1.1 21:59:09 INFO - requests == 1.2.3 21:59:09 INFO - wsgiref == 0.1.2 21:59:09 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 21:59:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:59:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:59:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:59:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:59:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:59:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:59:09 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 0x7fe36a8d0c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21496c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x220a6e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2240a90>, '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 0x2292f70>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22932e0>, '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': '256b35f542ca8bede9e27f1f00000291-1447998187.971045-1073784541', '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 21:59:09 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 21:59:09 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 21:59:09 INFO - Using env: {'DISPLAY': ':0', 21:59:09 INFO - 'HOME': '/home/cltbld', 21:59:09 INFO - 'LANG': 'en_US.UTF-8', 21:59:09 INFO - 'LANGUAGE': 'en_US:en', 21:59:09 INFO - 'LOGNAME': 'cltbld', 21:59:09 INFO - 'MAIL': '/var/mail/cltbld', 21:59:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:59:09 INFO - 'MOZ_NO_REMOTE': '1', 21:59:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:59:09 INFO - 'NO_EM_RESTART': '1', 21:59:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:59:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 21:59:09 INFO - 'PWD': '/builds/slave/test-pgo', 21:59:09 INFO - 'SHELL': '/bin/bash', 21:59:09 INFO - 'SHLVL': '1', 21:59:09 INFO - 'TERM': 'linux', 21:59:09 INFO - 'TMOUT': '86400', 21:59:09 INFO - 'USER': 'cltbld', 21:59:09 INFO - 'XDG_SESSION_COOKIE': '256b35f542ca8bede9e27f1f00000291-1447998187.971045-1073784541', 21:59:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:59:09 INFO - '_': '/tools/buildbot/bin/python'} 21:59:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:59:09 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)) 21:59:09 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)) 21:59:09 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)) 21:59:09 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)) 21:59:09 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)) 21:59:09 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)) 21:59:09 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)) 21:59:09 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)) 21:59:09 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)) 21:59:09 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)) 21:59:09 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)) 21:59:09 INFO - Cleaning up... 21:59:09 INFO - Return code: 0 21:59:09 INFO - Running post-action listener: _resource_record_post_action 21:59:09 INFO - Running post-action listener: _start_resource_monitoring 21:59:09 INFO - Starting resource monitoring. 21:59:09 INFO - ##### 21:59:09 INFO - ##### Running install step. 21:59:09 INFO - ##### 21:59:09 INFO - Running pre-action listener: _resource_record_pre_action 21:59:09 INFO - Running main action method: install 21:59:09 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 21:59:09 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 21:59:10 INFO - Reading from file tmpfile_stdout 21:59:10 INFO - Detecting whether we're running mozinstall >=1.0... 21:59:10 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 21:59:10 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 21:59:10 INFO - Reading from file tmpfile_stdout 21:59:10 INFO - Output received: 21:59:10 INFO - Usage: mozinstall [options] installer 21:59:10 INFO - Options: 21:59:10 INFO - -h, --help show this help message and exit 21:59:10 INFO - -d DEST, --destination=DEST 21:59:10 INFO - Directory to install application into. [default: 21:59:10 INFO - "/builds/slave/test-pgo"] 21:59:10 INFO - --app=APP Application being installed. [default: firefox] 21:59:10 INFO - mkdir: /builds/slave/test-pgo/build/application 21:59:10 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'] 21:59:10 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 21:59:33 INFO - Reading from file tmpfile_stdout 21:59:33 INFO - Output received: 21:59:33 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 21:59:33 INFO - Running post-action listener: _resource_record_post_action 21:59:33 INFO - ##### 21:59:33 INFO - ##### Running run-tests step. 21:59:33 INFO - ##### 21:59:33 INFO - Running pre-action listener: _resource_record_pre_action 21:59:33 INFO - Running main action method: run_tests 21:59:33 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 21:59:33 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 21:59:33 INFO - Python 2.7.3 21:59:33 INFO - Return code: 0 21:59:33 INFO - grabbing minidump binary from tooltool 21:59:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:59:33 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2240a90>, '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 0x2292f70>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22932e0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 21:59:33 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test-pgo/build 21:59:33 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 21:59:33 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 21:59:33 INFO - Return code: 0 21:59:33 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 21:59:33 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 21:59:33 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 21:59:33 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 21:59:33 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 21:59:33 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'B2G-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Z2BrdRaaTa-ne8G6NhFIkQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-013', '--webServer', 'localhost'] in /builds/slave/test-pgo/build 21:59:33 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --debug --branchName B2G-Inbound --suite dromaeojs --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Z2BrdRaaTa-ne8G6NhFIkQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-013 --webServer localhost 21:59:33 INFO - Using env: {'DISPLAY': ':0', 21:59:33 INFO - 'HOME': '/home/cltbld', 21:59:33 INFO - 'LANG': 'en_US.UTF-8', 21:59:33 INFO - 'LANGUAGE': 'en_US:en', 21:59:33 INFO - 'LOGNAME': 'cltbld', 21:59:33 INFO - 'MAIL': '/var/mail/cltbld', 21:59:33 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 21:59:33 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 21:59:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:59:33 INFO - 'MOZ_NO_REMOTE': '1', 21:59:33 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 21:59:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:59:33 INFO - 'NO_EM_RESTART': '1', 21:59:33 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:59:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 21:59:33 INFO - 'PWD': '/builds/slave/test-pgo', 21:59:33 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 21:59:33 INFO - 'SHELL': '/bin/bash', 21:59:33 INFO - 'SHLVL': '1', 21:59:33 INFO - 'TERM': 'linux', 21:59:33 INFO - 'TMOUT': '86400', 21:59:33 INFO - 'USER': 'cltbld', 21:59:33 INFO - 'XDG_SESSION_COOKIE': '256b35f542ca8bede9e27f1f00000291-1447998187.971045-1073784541', 21:59:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:59:33 INFO - '_': '/tools/buildbot/bin/python'} 21:59:33 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/Z2BrdRaaTa-ne8G6NhFIkQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-013', '--webServer', 'localhost'] with output_timeout 3600 21:59:33 INFO - mozversion INFO | application_buildid: 20151119203157 21:59:33 INFO - mozversion INFO | application_changeset: 138cebd69d9227119e2947e4b2e2def7f6bac84f 21:59:33 INFO - mozversion INFO | application_display_name: Nightly 21:59:33 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 21:59:33 INFO - mozversion INFO | application_name: Firefox 21:59:33 INFO - mozversion INFO | application_remotingname: firefox 21:59:33 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/b2g-inbound 21:59:33 INFO - mozversion INFO | application_vendor: Mozilla 21:59:33 INFO - mozversion INFO | application_version: 45.0a1 21:59:33 INFO - mozversion INFO | platform_buildid: 20151119203157 21:59:33 INFO - mozversion INFO | platform_changeset: 138cebd69d9227119e2947e4b2e2def7f6bac84f 21:59:33 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/b2g-inbound 21:59:33 INFO - mozversion INFO | platform_version: 45.0a1 21:59:33 INFO - 2015-11-19 21:59:33,322 DEBUG : using testdate: 1447999173 21:59:33 INFO - 2015-11-19 21:59:33,322 DEBUG : actual date: 1447999173 21:59:33 INFO - 2015-11-19 21:59:33,370 INFO : starting webserver on 'localhost:52052' 21:59:33 INFO - 2015-11-19 21:59:33,372 INFO : Starting test suite talos-linux64-ix-013 21:59:33 INFO - 2015-11-19 21:59:33,372 INFO : Starting test dromaeo_css 21:59:33 INFO - 2015-11-19 21:59:33,372 DEBUG : operating with platform_type : linux_ 21:59:33 INFO - 2015-11-19 21:59:33,372 INFO : Initialising browser for dromaeo_css test... 21:59:33 INFO - 2015-11-19 21:59:33,386 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp2Lt381/profile http://localhost:52052/getInfo.html 22:00:29 INFO - 2015-11-19 22:00:29,861 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 22:00:29 INFO - 2015-11-19 22:00:29,861 DEBUG : BROWSER_OUTPUT: colorDepth:24 22:00:29 INFO - 2015-11-19 22:00:29,861 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 22:00:29 INFO - 2015-11-19 22:00:29,861 DEBUG : BROWSER_OUTPUT: __metrics 22:00:30 INFO - 2015-11-19 22:00:30,810 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:00:36 INFO - 2015-11-19 22:00:36,524 INFO : Browser initialized. 22:00:36 INFO - 2015-11-19 22:00:36,524 INFO : Running cycle 1/1 for dromaeo_css test... 22:00:36 INFO - 2015-11-19 22:00:36,525 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp2Lt381/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 22:00:48 INFO - 2015-11-19 22:00:48,336 DEBUG : BROWSER_OUTPUT: RSS: Main: 140849152 22:00:48 INFO - 2015-11-19 22:00:48,337 DEBUG : BROWSER_OUTPUT: 22:01:39 INFO - 2015-11-19 22:01:39,958 DEBUG : BROWSER_OUTPUT: 1447999299955 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] 22:03:52 INFO - 2015-11-19 22:03:52,278 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52052/tests/dromaeo/cssquery-dojo.html (next: http://localhost:52052/tests/dromaeo/cssquery-ext.html) 22:03:53 INFO - 2015-11-19 22:03:53,287 DEBUG : BROWSER_OUTPUT: RSS: Main: 227999744 22:03:53 INFO - 2015-11-19 22:03:53,287 DEBUG : BROWSER_OUTPUT: 22:06:55 INFO - 2015-11-19 22:06:55,721 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52052/tests/dromaeo/cssquery-ext.html (next: http://localhost:52052/tests/dromaeo/cssquery-jquery.html) 22:06:56 INFO - 2015-11-19 22:06:56,289 DEBUG : BROWSER_OUTPUT: RSS: Main: 227446784 22:06:56 INFO - 2015-11-19 22:06:56,289 DEBUG : BROWSER_OUTPUT: 22:09:58 INFO - 2015-11-19 22:09:58,221 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52052/tests/dromaeo/cssquery-jquery.html (next: http://localhost:52052/tests/dromaeo/cssquery-mootools.html) 22:09:58 INFO - 2015-11-19 22:09:58,787 DEBUG : BROWSER_OUTPUT: RSS: Main: 222060544 22:09:58 INFO - 2015-11-19 22:09:58,787 DEBUG : BROWSER_OUTPUT: 22:13:00 INFO - 2015-11-19 22:13:00,688 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52052/tests/dromaeo/cssquery-mootools.html (next: http://localhost:52052/tests/dromaeo/cssquery-prototype.html) 22:13:01 INFO - 2015-11-19 22:13:01,261 DEBUG : BROWSER_OUTPUT: RSS: Main: 203644928 22:13:01 INFO - 2015-11-19 22:13:01,261 DEBUG : BROWSER_OUTPUT: 22:16:03 INFO - 2015-11-19 22:16:03,760 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52052/tests/dromaeo/cssquery-prototype.html (next: http://localhost:52052/tests/dromaeo/cssquery-yui.html) 22:16:04 INFO - 2015-11-19 22:16:04,353 DEBUG : BROWSER_OUTPUT: RSS: Main: 208195584 22:16:04 INFO - 2015-11-19 22:16:04,353 DEBUG : BROWSER_OUTPUT: 22:19:06 INFO - 2015-11-19 22:19:06,948 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52052/tests/dromaeo/cssquery-yui.html (next: http://localhost:52052/tests/dromaeo/cssquery-dojo.html) 22:19:07 INFO - 2015-11-19 22:19:07,199 DEBUG : BROWSER_OUTPUT: RSS: Main: 252452864 22:19:07 INFO - 2015-11-19 22:19:07,199 DEBUG : BROWSER_OUTPUT: 22:19:07 INFO - 2015-11-19 22:19:07,200 DEBUG : BROWSER_OUTPUT: __start_tp_report 22:19:07 INFO - 2015-11-19 22:19:07,200 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 22:19:07 INFO - 2015-11-19 22:19:07,200 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 22:19:07 INFO - 2015-11-19 22:19:07,200 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 22:19:07 INFO - 2015-11-19 22:19:07,200 DEBUG : BROWSER_OUTPUT: |0;dojo.html;3140.387624413239;3213.4215841148584;3260.3968265870817;3263.8857639982607;3282.458394364929;5184.585233181346;5284.0752868248;5383.865403364918;5396.244525766391;5490.835274941748;5281.207818827178;5331.57347412207;5335.653182543132;5392.973035134819;5394.05604019297;4885.804567817292;4925.064237794825;4934.111859865223;4940.382452193476;5002.899942001158;4945.23348880924;5049.520295571915;5051.267566202899;5055.848324550269;5088.211327244283;4817.470078291385;4921.630877684152;4939.259111133323;4987.127252730794;4988.825391111293;4953.90092198154;4968.975155124237;4969.155243608595;4971.900561988776;4973.204287314049;4842.15262329091;4865.537773911473;4918.336024636664;4928.408590969071;4932.901341973176;5122.948770512322;5129.12804823181;5129.153689641204;5138.203578445347;5168.5606723428555;5718.971405142989;5729;5730.398308177665;5733.111367738007;5739.713014349308;5705.030144875381;5772.07646776518;5838.036723940587;5842.415758424124;5952.047672372443;5476.342838859362;5478.753456094485;5478.780848766084;5486.984907792032;5543.334799824007;5895.941040589625;5949.137375080589;5964.671943043088;5976.133460648181;5977.6114552553945;5551.694656793915;5663.093904975184;5712.428757124254;5725.885482290331;5790.478856902899;5832.795852145155;5843.2403787507355;5843.561732870052;5847.3275573308765;5901.76392944286;5815.563832712563;5818.301803783488;5819.621724587888;5820.679862607597;5823;5647.887042259132;5677.971610141923;5782.88434231313;5794.362620111784;5819.388964158787;4478.0596074824;4483.955160448354;4525.185466616041;4526.79629416677;4531.320301954733;3996.86010989614;4000.699947503949;4005.5794141615293;4013.5585085640555;4036.2129384769687;5297.655652382583;5411.134218525017;5434.456554344613;5475.561955043587;5479.04116779562;5756.740946657411;5760.395158508296;5763.106718458645;5778.682172480554;5871.060630299217;5367.892642147135;5415.83752487426;5425.403205647375;5433.1850222466155;5448.237246785453;4949.158643030693;4967.975160124176;5059.367579052619;5088;5104.259882317043;5963.254593175853;5967.791127310524;5973.283206015219;5973.820785376446;5978.491828194478;5750.6262092963825;5757.395473475225;5759.366469688247;5761.625494342854;5763.7406316715005;5875.383084776208;5950.613210141327;5983.640981541122;5984.102384642339;6070.1501789750355;5623.943760562342;5664.065429204135;5670.8015219467125;5697.772089116389;5742.684152371659;5742.971285143548;5763.394843541368;5763.827085187451;5765.250517432707;5770.047942089508;5386.461353864739;5485.204645326485;5627.606067575231;5696.515796157373;5742.310922689304;5646.237757902631;5654.180143879197;5656.264685591012;5657.066584013592;5663.801766938137;5387.299651045339;5526.171074338881;5572.554195664418;5576.776928922797;5586.497215250484;5563.193336966036;5631.521320687623;5791.362950075404;5796.42035796417;5811.79658711943;5477.507024367826;5478.91781623284;5482.616216864941;5485.424030476743;5494 22:19:07 INFO - 2015-11-19 22:19:07,201 DEBUG : BROWSER_OUTPUT: |1;ext.html;586.9266341707287;588.7792077970761;592.354333776184;594.8037147741243;609.9786507472239;31429.528557071662;39978.800105999464;40520.79739601298;40605.390919136196;40664.39003414944;42907.3563896541;43383.78308108455;43397.13205735891;43402.34896476555;43447.56552434475;7528.284812942762;7641.1976742442075;8755.781105472382;8931.10688931105;8936.687215947442;10356.119729822974;10637.840432393521;10644.57421703131;10647.84028239577;10649.307794993301;10422.843657345145;10523.473826308693;10528.210384221176;10528.78942421151;10539.209559283085;7758.728444504443;7954.801129971739;10448.059674629281;10597.417142057184;10886.945565272123;10172.287939844215;10295.845562316572;10296.536655850505;10300.27898047137;10301.53643086063;30727.539086913715;40029;40525.79737101325;40537.189256215;40626.79686601578;2838.6451693538306;3298.7690861639694;3361.96638033619;3413.74396920232;3561.8041007744564;30128.397432051235;30509;30736.8463157685;30832.53751193734;31552;3880.553736320303;3916.4125381192766;3916.941245881314;3961.841526338943;3974.066094467798;273988;274214;274225;274938;275120;58082.12876806851;59809;61510.38489615046;62079.689601551705;68412.657936711;63261.36738632647;63356.36643633505;63576.36423635705;63637.36362636407;63698.36301636924;16437.83562164387;16496.587585310463;16704.83295167057;16710.498685039467;16725.581860453585;12802.871971280169;12875.678108047374;12882.871171288354;12885.806712899313;12901.483940642456;20164;20454.079566419547;20656.896715516326;20682.138607525394;20734.79265207359;7951.5626640534165;8031.518108913484;8083.797905052421;8107.108218096005;8168.183181681784;975.7170420578095;979.5298256836759;981.7692842182081;1001.9398836069713;1090.1061129873585;28387.71612283892;29158.27104322409;29300.267493312836;29383;31627.52558711621;1033.5865653738565;1037.600523798328;1044.3316277582353;1056.3767377247461;1073.393532654048;13560.59318220455;13633.727325453436;13771.311434428238;13821.654458638615;13925.442982280798;314331;316507;317295;318515;319138;51857.2221416679;52022.47977520252;52064;52066;52111;1353.2354219865745;1374.9931250343684;1380.1581035568295;1387.6877702516854;1388.4931999820194;24867.378315541533;26902.32744181411;27302.317442064108;28996.42007159803;29085.85457072701;47334.763326184526;48145.518544814106;48548.2717759241;48571.27143092786;48667.75666121647;260454;262612;262882;263662;263718;28018.439631207668;28391.716082838906;32204.516932246504;32318.515222272155;32476.350472990882;39458.80270598629;41428.79285603673;42318;42336;42352.36471452869;35483.29033419369;35796.284074317846;36398.454023189144;37022.44466333061;37084.51661933492;35632.28735425329;35970.8201458991;35987.560497579805;36179.81910090433;36600.63399366079;33156.1710957228;33895;34234.315313693085;34240.486392704624;34247.657523424445;31391.372172555963;32237.51643725299;33656.326873461905;33661.3267734639;33696.49455258124;25066.122685705912;25266.494670106127;25455.618165727898;25633.743662563134;25789.097381591553 22:19:07 INFO - 2015-11-19 22:19:07,203 DEBUG : BROWSER_OUTPUT: |2;jquery.html;345.36108199830335;356.2732026665602;360.0817914318488;360.60873951762335;363.7871844970692;13673.111247768888;13980.300984950763;16335.183240837956;16412;16877.57806054849;15770.448034318773;15991.280392382341;16654.750178747297;16665.41671041514;16685.666286674288;4678.672492925497;4804;4826.3001864729595;4828.830990915319;4829.541193586604;3633.5458067741533;3703.0557207911943;4848.927266091011;5227.477252274761;5378.704171270579;5286.920696189561;5303.390110137326;5326.6005049621235;5351.197320401932;5361.892762144755;5349.946500535003;5583.302087239095;5751.223584816038;5794.5943783935145;5814.302283725959;5167.457416971201;5184.662996905189;5203.453637368098;5205.349331333583;5213.635045546814;16699.582510437216;20687.0690818912;20918.5816283675;21271.468213294636;21317.893410533004;1950.54162271866;1987.6720341143694;2073.1914553324214;2078.9480262993393;2085.0304608357187;9516.286278529069;9686.031396860328;9927.056929591678;11010.119190464744;12808.359582020956;1795.721663142202;1808.1682426084017;1831.1668190973076;1881.8776779509287;1889.3198448558508;57473.425265747224;58996.82006359892;61438.69280653613;61522.38477615211;62184.378156218765;10239.590416383262;10292.992866390981;10315.690529284133;10320.793584128276;10350.53422595985;13588.79616805729;13634.454621815017;13676.247806370746;13684.31578421075;13687.520936767165;7308.634568271672;7342.5227360221415;7351.77944661661;7521.285477879593;7607.619619019027;7175.282471752887;7209.459290553229;7273.6726847292;7339.633018349061;7348.2284360142485;4419.911601768011;4486.685931984795;4487.910241795146;4532.841350552715;4546.386237857913;1727.1191692236798;1773.3527262549076;1795.2818872451123;1801.4055361730598;1819.8453131483973;451.9548045195454;967.5355829201882;974.8342781727123;1002.6540843409158;1062.6440142552176;10248.795024099625;10450.68647940563;10509.211809114347;10509.474526273656;10778.622748203776;412.17770547757414;422.38964696013966;439.31028285591316;452.7351499372904;453.17974466216253;5639.774409023676;5733.168690539848;5802.071668533014;5842.620229685057;5886.470217680429;521083;526130;527695;533720;534759;76412.61793691108;80522.59738701386;81280.18719812845;82363;82887;1169.8011338072547;1175.7295821960997;1191.1007189571817;1213.1144264686827;1235.8022716365338;15246.31391587359;15401.845981540042;15413.229338533252;15465.536033919001;15813.762793558337;34054.48918266278;34557;34583.82708086444;34896.47655285223;34920.22350378603;44523.777381112886;45406.31890521579;46033.30950035819;48094;48972.75513622409;9170.266378689823;9517.714468565953;9642.325037247325;9643.373180743229;9652.71041868717;11227.21409501327;16322.836771632607;16344.67310653804;17023.574410639834;17093.658126837145;14488.492902748354;14630.70738585201;14665.120092794466;14671.779923300946;14693.463941901604;14552.85447145515;14620.780688289897;14759.852401475848;14898.1806000671;15084.622884427537;11719.648410547697;15163.848361516244;15248;15317.540473785804;15329.853820464921;8659.653613855375;9830.508474576385;9836.458994755358;9912.454814985245;9918.652847150315;10450.111740502143;10564.049235568837;12293.877061229274;14175.291235438393;14303.928480357532 22:19:07 INFO - 2015-11-19 22:19:07,204 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1499.3702644889145;1501.4519700309384;1598.1074255597362;1752.1677203328416;1810.0176139323721;6663.466922646189;7048.894266585999;7211.9639401802915;7243.2032476427685;7246.420286377091;7483.438742094351;7504.137024242214;7531.096268447794;7542.9245707542905;7553.811154721135;1949.8635095543318;1981.375866602023;2256.751757306699;2270.2621647964397;2275.306031660343;2260.728712554496;2288.6567014947723;2307.1348244408346;2307.8038366738847;2308.3536609749212;2231.1967691631;2268.1947908492493;2278.943026424336;2279.076973825603;2280.247518318951;1974.2596526302636;2008.4175589079223;2232.029067355689;2266.660000999855;2271.954560908789;2171.826253899684;2263.4680850000236;2265.275111964172;2265.592193405186;2270.818334533233;7585.317321441097;7689.38484921205;7720.652570634279;7722.343600793939;7728.961355193244;4527.569880861313;4611.423572053493;4614.700044497097;4616.8153273869;4619.3763841881255;3246.821424821634;3246.935061298761;3288.408086544421;3298.09302441828;3306.636270010297;1086.630545614487;1922.6346994071082;1930.8744931579402;1932.2753967262277;1940.262700173925;10096.444695541742;10138.188944884392;10157.847632285522;10170.898291017069;10178.847317290247;4117.8970525736495;4130.256553820281;4188.4136220929095;4197.979010104991;4263.680223983151;8685.91314086851;8693.391462597683;8694;8700.08649091849;8711.215990560753;4672.556107169813;4690.03854209893;4717.363155973968;4719.268513380432;4724.834630787975;4343.978280108642;4347.413099231627;4349.325854492558;4351.521332653406;4356.106998065452;3357.748168887343;3383.678550537695;3394.745394095453;3405.659434056624;3423.0415483664615;1006.1498034161123;1016.3749294184172;1021.39737554843;1038.9116925061303;1041.4116024446164;1371.9245441500814;1381.8410882748412;1405.57130075328;1405.9156450612995;1409.9224542650252;6586.473082153416;7229.132504099542;7577.621118944031;7596.734114305973;7600.125985511626;583.5739909865822;590.4538302070567;592.4904582059512;629.8330942300294;631.8136149835809;5684.573656975744;5738;5740.856478587985;5758.913616295675;5765.250517432791;8947.686830960885;8967.148120928632;9081;9103.81792364149;9123.863142052875;8897.955510222408;8920.197182253498;9034.412763170372;9047.547622618842;9050.366474346733;6846.075779769667;7042.225355210922;7048.541844780176;7118.786436406916;7119.786406407816;6859.622720750406;6861.348171923659;6862;6879.828004299932;6880.965595171992;7678.8080297993;7939.404544659289;8105.716299929474;8115;8122.5126492410645;8154.103048664523;8290.58547072656;8330.416870818985;8331.041930178108;8340.124286950026;6659.300773418721;6888.138982627172;6934.16789985205;6937.340952609494;6939.410150137093;7234.891476627749;7330.706771729071;7333;7333.303336183054;7348.154962179417;6830.385265326145;6899.724011039703;6965.407940325129;6996.755113571001;7054.929450705427;6783.966080169567;6788.2193547742645;6892.172939247122;6939.410150137295;6954.652267386711;6237.688115594293;6404.1674582304;6581.80254592363;6841.521093523405;6873.450123989969;6358.523110766803;6573.342665733579;6599.208095028435;6625.17185351831;6628.237752658506;6600.768973085919;6650.700718467584;6683.598984060972;6683.83290417724;6686.431653309523 22:19:07 INFO - 2015-11-19 22:19:07,204 DEBUG : BROWSER_OUTPUT: |4;prototype.html;324.57480700282633;339.0455866735141;344.95688038995127;348.9441689329708;354.62409845563707;6073.878522429549;6080.300765411979;6095.146679464873;6096.908546371808;6099.6275837936555;5991.011483105282;6017.187679663244;6020.698965051741;6021.45806877381;6030.33666296707;4685.273782563691;4702.98885739566;4703.412073490814;4706.247000479924;4709.693869898463;4586.793594288265;4662.13750456165;4685.625149987993;4690.624750019991;4694.953050469503;4627.213373726458;4628.652851036169;4635.049814787961;4635.327877457784;4639.6752227344095;4400.933985990213;4478.798454069574;4636.211843986531;4662.97668511657;4666.020135771492;4029.9194016119804;4094.3653733671326;4124.628783409477;4135.855245066408;4136.937945930814;5646.971765141189;5675.772969081232;5692.57305702074;5704.458076482728;5705.115707065412;5079.517445842639;5207.6875387476875;5250.422453530108;5396.64921780083;5409.56723462122;6357.618542887441;6361.777337793202;6365.8408539786415;6389.744410223586;6393;4530.614897733697;4532.909341813145;4534.77326133692;4535.160995215896;4536.160810250114;6536.313687062838;6598.142241508621;6630.204375474926;6672.366125218096;6672.699728512229;4534.59188673021;4539.84110556129;4542.523035081335;4543.704659197141;4543.954560454419;4569.520200378979;4599.747013914267;4599.977000115045;4600.42494688164;4601.746903920316;5304.177852432879;5305.071612467803;5305.495977882095;5310.230016647564;5314.707691077027;6292.528060395489;6389.456896163878;6437.485001199892;6443.6455994920725;6458.806235812933;1664.4424117920632;1684.9747253791204;1685.3932584269653;1685.9325626974783;1687.5949772054619;1103.8896110389057;1144.1418935798151;1150.1201580790703;1163.8603367595942;1171.6719318590808;6243.157173781481;6244.250689917239;6246.250449946036;6249.187605611241;6251.718672659741;6597.538172327891;6656.101426307483;6661.500387470959;6666.266710661824;6669.333066693292;6082.482988945989;6177.907331390033;6240.375962403723;6257.874842503215;6258.280297765815;3590.622984586581;3592.173800026009;3616.1863580694135;3618.8371523281517;3623.8550457981387;6720.966395167993;6739.258681545026;6748.089007983957;6749.156355455568;6751.189857217068;6541.542092053605;6580.86838263232;6788.389044985975;6794.150731158606;6794.830129246809;6845.8973115403305;6922.723091076401;6928.757493487704;6938.27148149437;6960.825979350456;6690.531662783558;6695.598264104169;6696.062551242732;6696.062551242732;6698.631575263407;6474.2878283387845;6600.933990660032;6626.105475760711;6631.502637302126;6646.401823835685;6919.515633905578;6929.1684997800585;6930.13373328334;6933.826654333682;6938.791836244921;4666.906661866811;4669.276262179367;4669.696469729457;4673.299005149255;4675.111728771522;6475.870482590228;6620.63586502747;6649.867002659823;6655.600663960178;6657.833554161185;6480.125183100221;6491.123698300669;6514.413702766774;6522.34776522344;6523.217213934358;6523.18460192476;6524.739010439529;6526;6532.183477065367;6541.149650545399;6217.875642487215;6386.297507274289;6397.360263973565;6402;6407.327230640715;6541.738330466728;6556.688662267661;6558.672066396756;6559.704813283318;6560.179977502812;6339.904901426575;6369.713362898773;6390.808275751735;6406.519511036598;6412.839679008062 22:19:07 INFO - 2015-11-19 22:19:07,205 DEBUG : BROWSER_OUTPUT: |5;yui.html;857.9442336248144;863.3222920007795;867.3668222197795;881.95590220489;884.261641529323;13568.932155339222;13829.515966941146;13905.443782248723;13924.58226253214;13983.161010339387;12846.614601561969;14081.929590352034;14173;14182.361793719281;14198.78701819471;697.8185671725337;823.3618945317382;828.4904783558129;829.0134739659785;831.2601784411878;698.1203683358979;803.0564087197549;804.2279411764713;812.9349652027853;828.0684230240979;843.616154649636;843.6498852976008;844.5312851367488;849.4818160921833;868.7958329792493;721.8231533274355;730.5762657658545;843.1652663862762;867.9522626255554;881.6209030117047;619.0188551146439;619.3651507205105;619.5663035874906;636.6212103798279;651.3323843060853;13475.19148851072;13493.797593036112;13593.32033398336;13598.660033499242;13606.455741770318;11441.885581144164;11947.223430476992;12041.217320874115;12685.492580296777;12781.721827817237;10247.692569222936;10316.277860549764;10320.122789562896;10326.01902819231;10449.26855120142;3350.9832450837835;3377.645347238529;3385.2890892912274;3427;3481.8433170507133;49252.75373623109;51091.744541277054;51160.48839511594;51635;51752.74123629396;9572.712818615453;9605.279604029725;9613.90386096144;9642.084002019797;9716.514174291256;17628.118594070245;17687.115644217996;17719;17768.822311776716;17797.555061123574;6944.756933507303;7076.540024898365;7090.290970902868;7180.31786980236;7277.8544429111125;4406.537313582092;4423.159599676052;4423.225935461346;4443.8000289986385;4484.349769283435;3260.5924259467565;3277.770556061053;3285.4086264472626;3288;3338;567.234233784396;586.4633860018121;597.6653074278418;606.5966132521912;613.2763339259716;680.2585182151479;680.391050010238;695.6834640238679;706.2337363960161;708.9078419805495;8537.359698022548;8776.429532080521;9036.186743193144;9183.908160918305;9730.172935300438;508.3569284854662;616.6207782213907;651.1274891645218;697.341012742953;782.2803021220377;3872.6514613684903;3975.1254723960683;3993.72043956926;4207.305794543866;4223.746575205498;57567;57626;57842.71078644664;58319.70840145857;61897.69051154715;49908;50401.49598504041;50680.74659626752;50693.74653126785;51210;45292.773536132765;46272.30591541129;46363;46710;46968.5303146971;8345.624446900025;8503.574821259035;8855.60149793248;8917.866232006654;9009.954950225207;32621.18447038843;33914.152146196546;34193.14517137092;34247.31505369928;34887.65112348844;42216.577834221265;42752.78623606862;42932.35601466043;43371;43473.56526434822;10949.781004379709;10996.945015274872;11003.394813285346;11051.115910726961;11071.72320691989;12098.274103553815;12124.416423925593;12164.148509604243;12315.568955086528;12428.254304741744;11552.59565915189;11825.70435739079;11893.524259029542;12212.450439730412;12488.625341239778;11254.493547790533;11553.133514986577;11592.47833847462;11616.651500455;11986.820197697216;7790;11328.830067549157;11355.318680879174;11490.655280341603;11883.049356051322;9612.726820780512;9857.654982075594;10019.735993890501;10210.846837297298;10387.37675739458;9486.92062413169;9894.29302214047;9945.303828732209;9948.701538953843;9992.550335234786 22:19:07 INFO - 2015-11-19 22:19:07,205 DEBUG : BROWSER_OUTPUT: __end_tp_report 22:19:07 INFO - 2015-11-19 22:19:07,205 DEBUG : BROWSER_OUTPUT: __start_cc_report 22:19:07 INFO - 2015-11-19 22:19:07,205 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,805 22:19:07 INFO - 2015-11-19 22:19:07,206 DEBUG : BROWSER_OUTPUT: __end_cc_report 22:19:07 INFO - 2015-11-19 22:19:07,206 DEBUG : BROWSER_OUTPUT: __startTimestamp1448000347197__endTimestamp 22:19:07 INFO - 2015-11-19 22:19:07,206 DEBUG : BROWSER_OUTPUT: 22:19:07 INFO - 2015-11-19 22:19:07,206 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 22:19:07 INFO - 2015-11-19 22:19:07,206 DEBUG : BROWSER_OUTPUT: Number of tests: 6 22:19:07 INFO - 2015-11-19 22:19:07,206 DEBUG : BROWSER_OUTPUT: 22:19:07 INFO - 2015-11-19 22:19:07,206 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:5370.80 Median:5526.17 stddev:585.84 (10.6%) stddev-sans-first:560.89 22:19:07 INFO - 2015-11-19 22:19:07,206 DEBUG : BROWSER_OUTPUT: Values: 3140.4 3213.4 3260.4 3263.9 3282.5 5184.6 5284.1 5383.9 5396.2 5490.8 5281.2 5331.6 5335.7 5393.0 5394.1 4885.8 4925.1 4934.1 4940.4 5002.9 4945.2 5049.5 5051.3 5055.8 5088.2 4817.5 4921.6 4939.3 4987.1 4988.8 4953.9 4969.0 4969.2 4971.9 4973.2 4842.2 4865.5 4918.3 4928.4 4932.9 5122.9 5129.1 5129.2 5138.2 5168.6 5719.0 5729.0 5730.4 5733.1 5739.7 5705.0 5772.1 5838.0 5842.4 5952.0 5476.3 5478.8 5478.8 5487.0 5543.3 5895.9 5949.1 5964.7 5976.1 5977.6 5551.7 5663.1 5712.4 5725.9 5790.5 5832.8 5843.2 5843.6 5847.3 5901.8 5815.6 5818.3 5819.6 5820.7 5823.0 5647.9 5678.0 5782.9 5794.4 5819.4 4478.1 4484.0 4525.2 4526.8 4531.3 3996.9 4000.7 4005.6 4013.6 4036.2 5297.7 5411.1 5434.5 5475.6 5479.0 5756.7 5760.4 5763.1 5778.7 5871.1 5367.9 5415.8 5425.4 5433.2 5448.2 4949.2 4968.0 5059.4 5088.0 5104.3 5963.3 5967.8 5973.3 5973.8 5978.5 5750.6 5757.4 5759.4 5761.6 5763.7 5875.4 5950.6 5983.6 5984.1 6070.2 5623.9 5664.1 5670.8 5697.8 5742.7 5743.0 5763.4 5763.8 5765.3 5770.0 5386.5 5485.2 5627.6 5696.5 5742.3 5646.2 5654.2 5656.3 5657.1 5663.8 5387.3 5526.2 5572.6 5576.8 5586.5 5563.2 5631.5 5791.4 5796.4 5811.8 5477.5 5478.9 5482.6 5485.4 5494.0 22:19:07 INFO - 2015-11-19 22:19:07,206 DEBUG : BROWSER_OUTPUT: 22:19:07 INFO - 2015-11-19 22:19:07,207 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:46045.35 Median:175671.26 stddev:74520.70 (42.4%) stddev-sans-first:74651.58 22:19:07 INFO - 2015-11-19 22:19:07,208 DEBUG : BROWSER_OUTPUT: Values: 586.9 588.8 592.4 594.8 610.0 31429.5 39978.8 40520.8 40605.4 40664.4 42907.4 43383.8 43397.1 43402.3 43447.6 7528.3 7641.2 8755.8 8931.1 8936.7 10356.1 10637.8 10644.6 10647.8 10649.3 10422.8 10523.5 10528.2 10528.8 10539.2 7758.7 7954.8 10448.1 10597.4 10886.9 10172.3 10295.8 10296.5 10300.3 10301.5 30727.5 40029.0 40525.8 40537.2 40626.8 2838.6 3298.8 3362.0 3413.7 3561.8 30128.4 30509.0 30736.8 30832.5 31552.0 3880.6 3916.4 3916.9 3961.8 3974.1 273988.0 274214.0 274225.0 274938.0 275120.0 58082.1 59809.0 61510.4 62079.7 68412.7 63261.4 63356.4 63576.4 63637.4 63698.4 16437.8 16496.6 16704.8 16710.5 16725.6 12802.9 12875.7 12882.9 12885.8 12901.5 20164.0 20454.1 20656.9 20682.1 20734.8 7951.6 8031.5 8083.8 8107.1 8168.2 975.7 979.5 981.8 1001.9 1090.1 28387.7 29158.3 29300.3 29383.0 31627.5 1033.6 1037.6 1044.3 1056.4 1073.4 13560.6 13633.7 13771.3 13821.7 13925.4 314331.0 316507.0 317295.0 318515.0 319138.0 51857.2 52022.5 52064.0 52066.0 52111.0 1353.2 1375.0 1380.2 1387.7 1388.5 24867.4 26902.3 27302.3 28996.4 29085.9 47334.8 48145.5 48548.3 48571.3 48667.8 260454.0 262612.0 262882.0 263662.0 263718.0 28018.4 28391.7 32204.5 32318.5 32476.4 39458.8 41428.8 42318.0 42336.0 42352.4 35483.3 35796.3 36398.5 37022.4 37084.5 35632.3 35970.8 35987.6 36179.8 36600.6 33156.2 33895.0 34234.3 34240.5 34247.7 31391.4 32237.5 33656.3 33661.3 33696.5 25066.1 25266.5 25455.6 25633.7 25789.1 22:19:07 INFO - 2015-11-19 22:19:07,208 DEBUG : BROWSER_OUTPUT: 22:19:07 INFO - 2015-11-19 22:19:07,208 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:28153.76 Median:358.18 stddev:86479.35 (24144.3%) stddev-sans-first:86696.74 22:19:07 INFO - 2015-11-19 22:19:07,208 DEBUG : BROWSER_OUTPUT: Values: 345.4 356.3 360.1 360.6 363.8 13673.1 13980.3 16335.2 16412.0 16877.6 15770.4 15991.3 16654.8 16665.4 16685.7 4678.7 4804.0 4826.3 4828.8 4829.5 3633.5 3703.1 4848.9 5227.5 5378.7 5286.9 5303.4 5326.6 5351.2 5361.9 5349.9 5583.3 5751.2 5794.6 5814.3 5167.5 5184.7 5203.5 5205.3 5213.6 16699.6 20687.1 20918.6 21271.5 21317.9 1950.5 1987.7 2073.2 2078.9 2085.0 9516.3 9686.0 9927.1 11010.1 12808.4 1795.7 1808.2 1831.2 1881.9 1889.3 57473.4 58996.8 61438.7 61522.4 62184.4 10239.6 10293.0 10315.7 10320.8 10350.5 13588.8 13634.5 13676.2 13684.3 13687.5 7308.6 7342.5 7351.8 7521.3 7607.6 7175.3 7209.5 7273.7 7339.6 7348.2 4419.9 4486.7 4487.9 4532.8 4546.4 1727.1 1773.4 1795.3 1801.4 1819.8 452.0 967.5 974.8 1002.7 1062.6 10248.8 10450.7 10509.2 10509.5 10778.6 412.2 422.4 439.3 452.7 453.2 5639.8 5733.2 5802.1 5842.6 5886.5 521083.0 526130.0 527695.0 533720.0 534759.0 76412.6 80522.6 81280.2 82363.0 82887.0 1169.8 1175.7 1191.1 1213.1 1235.8 15246.3 15401.8 15413.2 15465.5 15813.8 34054.5 34557.0 34583.8 34896.5 34920.2 44523.8 45406.3 46033.3 48094.0 48972.8 9170.3 9517.7 9642.3 9643.4 9652.7 11227.2 16322.8 16344.7 17023.6 17093.7 14488.5 14630.7 14665.1 14671.8 14693.5 14552.9 14620.8 14759.9 14898.2 15084.6 11719.6 15163.8 15248.0 15317.5 15329.9 8659.7 9830.5 9836.5 9912.5 9918.7 10450.1 10564.0 12293.9 14175.3 14303.9 22:19:07 INFO - 2015-11-19 22:19:07,208 DEBUG : BROWSER_OUTPUT: 22:19:07 INFO - 2015-11-19 22:19:07,208 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5340.57 Median:3495.17 stddev:2691.80 (77.0%) stddev-sans-first:2683.87 22:19:07 INFO - 2015-11-19 22:19:07,209 DEBUG : BROWSER_OUTPUT: Values: 1499.4 1501.5 1598.1 1752.2 1810.0 6663.5 7048.9 7212.0 7243.2 7246.4 7483.4 7504.1 7531.1 7542.9 7553.8 1949.9 1981.4 2256.8 2270.3 2275.3 2260.7 2288.7 2307.1 2307.8 2308.4 2231.2 2268.2 2278.9 2279.1 2280.2 1974.3 2008.4 2232.0 2266.7 2272.0 2171.8 2263.5 2265.3 2265.6 2270.8 7585.3 7689.4 7720.7 7722.3 7729.0 4527.6 4611.4 4614.7 4616.8 4619.4 3246.8 3246.9 3288.4 3298.1 3306.6 1086.6 1922.6 1930.9 1932.3 1940.3 10096.4 10138.2 10157.8 10170.9 10178.8 4117.9 4130.3 4188.4 4198.0 4263.7 8685.9 8693.4 8694.0 8700.1 8711.2 4672.6 4690.0 4717.4 4719.3 4724.8 4344.0 4347.4 4349.3 4351.5 4356.1 3357.7 3383.7 3394.7 3405.7 3423.0 1006.1 1016.4 1021.4 1038.9 1041.4 1371.9 1381.8 1405.6 1405.9 1409.9 6586.5 7229.1 7577.6 7596.7 7600.1 583.6 590.5 592.5 629.8 631.8 5684.6 5738.0 5740.9 5758.9 5765.3 8947.7 8967.1 9081.0 9103.8 9123.9 8898.0 8920.2 9034.4 9047.5 9050.4 6846.1 7042.2 7048.5 7118.8 7119.8 6859.6 6861.3 6862.0 6879.8 6881.0 7678.8 7939.4 8105.7 8115.0 8122.5 8154.1 8290.6 8330.4 8331.0 8340.1 6659.3 6888.1 6934.2 6937.3 6939.4 7234.9 7330.7 7333.0 7333.3 7348.2 6830.4 6899.7 6965.4 6996.8 7054.9 6784.0 6788.2 6892.2 6939.4 6954.7 6237.7 6404.2 6581.8 6841.5 6873.5 6358.5 6573.3 6599.2 6625.2 6628.2 6600.8 6650.7 6683.6 6683.8 6686.4 22:19:07 INFO - 2015-11-19 22:19:07,209 DEBUG : BROWSER_OUTPUT: 22:19:07 INFO - 2015-11-19 22:19:07,209 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:5394.17 Median:6138.77 stddev:1613.63 (26.3%) stddev-sans-first:1572.65 22:19:07 INFO - 2015-11-19 22:19:07,209 DEBUG : BROWSER_OUTPUT: Values: 324.6 339.0 345.0 348.9 354.6 6073.9 6080.3 6095.1 6096.9 6099.6 5991.0 6017.2 6020.7 6021.5 6030.3 4685.3 4703.0 4703.4 4706.2 4709.7 4586.8 4662.1 4685.6 4690.6 4695.0 4627.2 4628.7 4635.0 4635.3 4639.7 4400.9 4478.8 4636.2 4663.0 4666.0 4029.9 4094.4 4124.6 4135.9 4136.9 5647.0 5675.8 5692.6 5704.5 5705.1 5079.5 5207.7 5250.4 5396.6 5409.6 6357.6 6361.8 6365.8 6389.7 6393.0 4530.6 4532.9 4534.8 4535.2 4536.2 6536.3 6598.1 6630.2 6672.4 6672.7 4534.6 4539.8 4542.5 4543.7 4544.0 4569.5 4599.7 4600.0 4600.4 4601.7 5304.2 5305.1 5305.5 5310.2 5314.7 6292.5 6389.5 6437.5 6443.6 6458.8 1664.4 1685.0 1685.4 1685.9 1687.6 1103.9 1144.1 1150.1 1163.9 1171.7 6243.2 6244.3 6246.3 6249.2 6251.7 6597.5 6656.1 6661.5 6666.3 6669.3 6082.5 6177.9 6240.4 6257.9 6258.3 3590.6 3592.2 3616.2 3618.8 3623.9 6721.0 6739.3 6748.1 6749.2 6751.2 6541.5 6580.9 6788.4 6794.2 6794.8 6845.9 6922.7 6928.8 6938.3 6960.8 6690.5 6695.6 6696.1 6696.1 6698.6 6474.3 6600.9 6626.1 6631.5 6646.4 6919.5 6929.2 6930.1 6933.8 6938.8 4666.9 4669.3 4669.7 4673.3 4675.1 6475.9 6620.6 6649.9 6655.6 6657.8 6480.1 6491.1 6514.4 6522.3 6523.2 6523.2 6524.7 6526.0 6532.2 6541.1 6217.9 6386.3 6397.4 6402.0 6407.3 6541.7 6556.7 6558.7 6559.7 6560.2 6339.9 6369.7 6390.8 6406.5 6412.8 22:19:07 INFO - 2015-11-19 22:19:07,210 DEBUG : BROWSER_OUTPUT: 22:19:07 INFO - 2015-11-19 22:19:07,210 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:13856.96 Median:46839.27 stddev:16032.63 (34.2%) stddev-sans-first:16047.89 22:19:07 INFO - 2015-11-19 22:19:07,210 DEBUG : BROWSER_OUTPUT: Values: 857.9 863.3 867.4 882.0 884.3 13568.9 13829.5 13905.4 13924.6 13983.2 12846.6 14081.9 14173.0 14182.4 14198.8 697.8 823.4 828.5 829.0 831.3 698.1 803.1 804.2 812.9 828.1 843.6 843.6 844.5 849.5 868.8 721.8 730.6 843.2 868.0 881.6 619.0 619.4 619.6 636.6 651.3 13475.2 13493.8 13593.3 13598.7 13606.5 11441.9 11947.2 12041.2 12685.5 12781.7 10247.7 10316.3 10320.1 10326.0 10449.3 3351.0 3377.6 3385.3 3427.0 3481.8 49252.8 51091.7 51160.5 51635.0 51752.7 9572.7 9605.3 9613.9 9642.1 9716.5 17628.1 17687.1 17719.0 17768.8 17797.6 6944.8 7076.5 7090.3 7180.3 7277.9 4406.5 4423.2 4423.2 4443.8 4484.3 3260.6 3277.8 3285.4 3288.0 3338.0 567.2 586.5 597.7 606.6 613.3 680.3 680.4 695.7 706.2 708.9 8537.4 8776.4 9036.2 9183.9 9730.2 508.4 616.6 651.1 697.3 782.3 3872.7 3975.1 3993.7 4207.3 4223.7 57567.0 57626.0 57842.7 58319.7 61897.7 49908.0 50401.5 50680.7 50693.7 51210.0 45292.8 46272.3 46363.0 46710.0 46968.5 8345.6 8503.6 8855.6 8917.9 9010.0 32621.2 33914.2 34193.1 34247.3 34887.7 42216.6 42752.8 42932.4 43371.0 43473.6 10949.8 10996.9 11003.4 11051.1 11071.7 12098.3 12124.4 12164.1 12315.6 12428.3 11552.6 11825.7 11893.5 12212.5 12488.6 11254.5 11553.1 11592.5 11616.7 11986.8 7790.0 11328.8 11355.3 11490.7 11883.0 9612.7 9857.7 10019.7 10210.8 10387.4 9486.9 9894.3 9945.3 9948.7 9992.6 22:19:07 INFO - 2015-11-19 22:19:07,210 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 22:19:07 INFO - 2015-11-19 22:19:07,210 DEBUG : BROWSER_OUTPUT: 22:19:08 INFO - 2015-11-19 22:19:08,400 INFO : Browser exited with error code: 0 22:19:08 INFO - 2015-11-19 22:19:08,418 INFO : Completed test dromaeo_css (00:19:35) 22:19:08 INFO - 2015-11-19 22:19:08,418 INFO : Starting test kraken 22:19:08 INFO - 2015-11-19 22:19:08,418 DEBUG : operating with platform_type : linux_ 22:19:08 INFO - 2015-11-19 22:19:08,419 INFO : Initialising browser for kraken test... 22:19:08 INFO - 2015-11-19 22:19:08,424 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpzvfP1Y/profile http://localhost:52052/getInfo.html 22:19:19 INFO - 2015-11-19 22:19:19,882 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 22:19:19 INFO - 2015-11-19 22:19:19,882 DEBUG : BROWSER_OUTPUT: colorDepth:24 22:19:19 INFO - 2015-11-19 22:19:19,882 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 22:19:19 INFO - 2015-11-19 22:19:19,882 DEBUG : BROWSER_OUTPUT: __metrics 22:19:20 INFO - 2015-11-19 22:19:20,403 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:19:24 INFO - 2015-11-19 22:19:24,996 INFO : Browser initialized. 22:19:24 INFO - 2015-11-19 22:19:24,996 INFO : Running cycle 1/1 for kraken test... 22:19:24 INFO - 2015-11-19 22:19:24,997 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpzvfP1Y/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 22:19:36 INFO - 2015-11-19 22:19:36,766 DEBUG : BROWSER_OUTPUT: RSS: Main: 142045184 22:19:36 INFO - 2015-11-19 22:19:36,766 DEBUG : BROWSER_OUTPUT: 22:19:39 INFO - 2015-11-19 22:19:39,220 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52052/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:52052/tests/kraken/driver.html?testName=audio-beat-detection) 22:19:39 INFO - 2015-11-19 22:19:39,815 DEBUG : BROWSER_OUTPUT: RSS: Main: 179355648 22:19:39 INFO - 2015-11-19 22:19:39,815 DEBUG : BROWSER_OUTPUT: 22:19:42 INFO - 2015-11-19 22:19:42,416 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52052/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:52052/tests/kraken/driver.html?testName=audio-dft) 22:19:42 INFO - 2015-11-19 22:19:42,985 DEBUG : BROWSER_OUTPUT: RSS: Main: 168042496 22:19:42 INFO - 2015-11-19 22:19:42,985 DEBUG : BROWSER_OUTPUT: 22:19:45 INFO - 2015-11-19 22:19:45,863 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52052/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:52052/tests/kraken/driver.html?testName=audio-fft) 22:19:46 INFO - 2015-11-19 22:19:46,416 DEBUG : BROWSER_OUTPUT: RSS: Main: 151855104 22:19:46 INFO - 2015-11-19 22:19:46,416 DEBUG : BROWSER_OUTPUT: 22:19:48 INFO - 2015-11-19 22:19:48,389 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52052/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:52052/tests/kraken/driver.html?testName=audio-oscillator) 22:19:48 INFO - 2015-11-19 22:19:48,954 DEBUG : BROWSER_OUTPUT: RSS: Main: 152559616 22:19:48 INFO - 2015-11-19 22:19:48,955 DEBUG : BROWSER_OUTPUT: 22:19:51 INFO - 2015-11-19 22:19:51,140 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52052/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:52052/tests/kraken/driver.html?testName=imaging-gaussian-blur) 22:19:51 INFO - 2015-11-19 22:19:51,693 DEBUG : BROWSER_OUTPUT: RSS: Main: 155607040 22:19:51 INFO - 2015-11-19 22:19:51,693 DEBUG : BROWSER_OUTPUT: 22:19:54 INFO - 2015-11-19 22:19:54,611 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52052/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:52052/tests/kraken/driver.html?testName=imaging-darkroom) 22:19:55 INFO - 2015-11-19 22:19:55,184 DEBUG : BROWSER_OUTPUT: RSS: Main: 155074560 22:19:55 INFO - 2015-11-19 22:19:55,184 DEBUG : BROWSER_OUTPUT: 22:19:58 INFO - 2015-11-19 22:19:58,800 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52052/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:52052/tests/kraken/driver.html?testName=imaging-desaturate) 22:19:59 INFO - 2015-11-19 22:19:59,387 DEBUG : BROWSER_OUTPUT: RSS: Main: 153993216 22:19:59 INFO - 2015-11-19 22:19:59,387 DEBUG : BROWSER_OUTPUT: 22:20:02 INFO - 2015-11-19 22:20:02,129 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52052/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:52052/tests/kraken/driver.html?testName=json-parse-financial) 22:20:02 INFO - 2015-11-19 22:20:02,698 DEBUG : BROWSER_OUTPUT: RSS: Main: 155860992 22:20:02 INFO - 2015-11-19 22:20:02,698 DEBUG : BROWSER_OUTPUT: 22:20:04 INFO - 2015-11-19 22:20:04,274 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52052/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:52052/tests/kraken/driver.html?testName=json-stringify-tinderbox) 22:20:04 INFO - 2015-11-19 22:20:04,835 DEBUG : BROWSER_OUTPUT: RSS: Main: 165896192 22:20:04 INFO - 2015-11-19 22:20:04,835 DEBUG : BROWSER_OUTPUT: 22:20:06 INFO - 2015-11-19 22:20:06,624 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52052/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:52052/tests/kraken/driver.html?testName=stanford-crypto-aes) 22:20:07 INFO - 2015-11-19 22:20:07,226 DEBUG : BROWSER_OUTPUT: RSS: Main: 166686720 22:20:07 INFO - 2015-11-19 22:20:07,226 DEBUG : BROWSER_OUTPUT: 22:20:09 INFO - 2015-11-19 22:20:09,237 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52052/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:52052/tests/kraken/driver.html?testName=stanford-crypto-ccm) 22:20:09 INFO - 2015-11-19 22:20:09,804 DEBUG : BROWSER_OUTPUT: RSS: Main: 173404160 22:20:09 INFO - 2015-11-19 22:20:09,804 DEBUG : BROWSER_OUTPUT: 22:20:12 INFO - 2015-11-19 22:20:12,210 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52052/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:52052/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 22:20:12 INFO - 2015-11-19 22:20:12,799 DEBUG : BROWSER_OUTPUT: RSS: Main: 182325248 22:20:12 INFO - 2015-11-19 22:20:12,800 DEBUG : BROWSER_OUTPUT: 22:20:15 INFO - 2015-11-19 22:20:15,307 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52052/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:52052/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 22:20:15 INFO - 2015-11-19 22:20:15,873 DEBUG : BROWSER_OUTPUT: RSS: Main: 183300096 22:20:15 INFO - 2015-11-19 22:20:15,873 DEBUG : BROWSER_OUTPUT: 22:20:17 INFO - 2015-11-19 22:20:17,513 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52052/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:52052/tests/kraken/driver.html?testName=ai-astar) 22:20:18 INFO - 2015-11-19 22:20:17,763 DEBUG : BROWSER_OUTPUT: RSS: Main: 240721920 22:20:18 INFO - 2015-11-19 22:20:17,763 DEBUG : BROWSER_OUTPUT: 22:20:18 INFO - 2015-11-19 22:20:17,767 DEBUG : BROWSER_OUTPUT: __start_tp_report 22:20:18 INFO - 2015-11-19 22:20:17,767 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 22:20:18 INFO - 2015-11-19 22:20:17,767 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 22:20:18 INFO - 2015-11-19 22:20:17,767 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 22:20:18 INFO - 2015-11-19 22:20:17,767 DEBUG : BROWSER_OUTPUT: |0;ai-astar;109;112;103;112;113;111;99;112;109;108 22:20:18 INFO - 2015-11-19 22:20:17,767 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;153;134;146;157;125;154;148;125;186;128 22:20:18 INFO - 2015-11-19 22:20:17,767 DEBUG : BROWSER_OUTPUT: |2;audio-dft;161;161;161;161;159;161;160;161;160;160 22:20:18 INFO - 2015-11-19 22:20:17,768 DEBUG : BROWSER_OUTPUT: |3;audio-fft;73;72;93;94;72;72;72;101;90;72 22:20:18 INFO - 2015-11-19 22:20:17,768 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;90;91;146;90;89;90;136;97;91;135 22:20:18 INFO - 2015-11-19 22:20:17,768 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;109;109;109;109;109;109;110;110;109;109 22:20:18 INFO - 2015-11-19 22:20:17,768 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;144;146;144;145;144;145;144;145;145;145 22:20:18 INFO - 2015-11-19 22:20:17,768 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;96;95;95;95;96;95;95;95;95;95 22:20:18 INFO - 2015-11-19 22:20:17,768 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;60;60;60;60;61;60;62;70;58;58 22:20:18 INFO - 2015-11-19 22:20:17,768 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;69;68;69;68;69;69;69;69;72;68 22:20:18 INFO - 2015-11-19 22:20:17,769 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;82;82;83;84;84;84;85;83;84;85 22:20:18 INFO - 2015-11-19 22:20:17,769 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;118;117;132;119;116;125;113;120;122;124 22:20:18 INFO - 2015-11-19 22:20:17,769 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;139;150;138;147;149;138;148;150;148;136 22:20:18 INFO - 2015-11-19 22:20:17,769 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;67;66;68;66;66;67;66;68;67;68 22:20:18 INFO - 2015-11-19 22:20:17,769 DEBUG : BROWSER_OUTPUT: __end_tp_report 22:20:18 INFO - 2015-11-19 22:20:17,769 DEBUG : BROWSER_OUTPUT: __start_cc_report 22:20:18 INFO - 2015-11-19 22:20:17,769 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,924 22:20:18 INFO - 2015-11-19 22:20:17,770 DEBUG : BROWSER_OUTPUT: __end_cc_report 22:20:18 INFO - 2015-11-19 22:20:17,770 DEBUG : BROWSER_OUTPUT: __startTimestamp1448000417764__endTimestamp 22:20:18 INFO - 2015-11-19 22:20:17,770 DEBUG : BROWSER_OUTPUT: 22:20:18 INFO - 2015-11-19 22:20:17,773 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 22:20:18 INFO - 2015-11-19 22:20:17,773 DEBUG : BROWSER_OUTPUT: Number of tests: 14 22:20:18 INFO - 2015-11-19 22:20:17,773 DEBUG : BROWSER_OUTPUT: 22:20:18 INFO - 2015-11-19 22:20:17,773 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:108.80 Median:112.00 stddev:4.52 (4.0%) stddev-sans-first:4.79 22:20:18 INFO - 2015-11-19 22:20:17,773 DEBUG : BROWSER_OUTPUT: Values: 109.0 112.0 103.0 112.0 113.0 111.0 99.0 112.0 109.0 108.0 22:20:18 INFO - 2015-11-19 22:20:17,774 DEBUG : BROWSER_OUTPUT: 22:20:18 INFO - 2015-11-19 22:20:17,774 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:145.60 Median:150.50 stddev:18.82 (12.5%) stddev-sans-first:19.77 22:20:18 INFO - 2015-11-19 22:20:17,774 DEBUG : BROWSER_OUTPUT: Values: 153.0 134.0 146.0 157.0 125.0 154.0 148.0 125.0 186.0 128.0 22:20:18 INFO - 2015-11-19 22:20:17,774 DEBUG : BROWSER_OUTPUT: 22:20:18 INFO - 2015-11-19 22:20:17,774 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:160.50 Median:161.00 stddev:0.71 (0.4%) stddev-sans-first:0.73 22:20:18 INFO - 2015-11-19 22:20:17,774 DEBUG : BROWSER_OUTPUT: Values: 161.0 161.0 161.0 161.0 159.0 161.0 160.0 161.0 160.0 160.0 22:20:18 INFO - 2015-11-19 22:20:17,774 DEBUG : BROWSER_OUTPUT: 22:20:18 INFO - 2015-11-19 22:20:17,774 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:81.10 Median:72.50 stddev:11.85 (16.3%) stddev-sans-first:12.20 22:20:18 INFO - 2015-11-19 22:20:17,774 DEBUG : BROWSER_OUTPUT: Values: 73.0 72.0 93.0 94.0 72.0 72.0 72.0 101.0 90.0 72.0 22:20:18 INFO - 2015-11-19 22:20:17,774 DEBUG : BROWSER_OUTPUT: 22:20:18 INFO - 2015-11-19 22:20:17,774 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:105.50 Median:90.00 stddev:23.40 (26.0%) stddev-sans-first:24.13 22:20:18 INFO - 2015-11-19 22:20:17,774 DEBUG : BROWSER_OUTPUT: Values: 90.0 91.0 146.0 90.0 89.0 90.0 136.0 97.0 91.0 135.0 22:20:18 INFO - 2015-11-19 22:20:17,774 DEBUG : BROWSER_OUTPUT: 22:20:18 INFO - 2015-11-19 22:20:17,774 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:109.20 Median:109.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 22:20:18 INFO - 2015-11-19 22:20:17,774 DEBUG : BROWSER_OUTPUT: Values: 109.0 109.0 109.0 109.0 109.0 109.0 110.0 110.0 109.0 109.0 22:20:18 INFO - 2015-11-19 22:20:17,775 DEBUG : BROWSER_OUTPUT: 22:20:18 INFO - 2015-11-19 22:20:17,775 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:144.70 Median:145.00 stddev:0.67 (0.5%) stddev-sans-first:0.67 22:20:18 INFO - 2015-11-19 22:20:17,775 DEBUG : BROWSER_OUTPUT: Values: 144.0 146.0 144.0 145.0 144.0 145.0 144.0 145.0 145.0 145.0 22:20:18 INFO - 2015-11-19 22:20:17,775 DEBUG : BROWSER_OUTPUT: 22:20:18 INFO - 2015-11-19 22:20:17,775 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:95.20 Median:95.00 stddev:0.42 (0.4%) stddev-sans-first:0.33 22:20:18 INFO - 2015-11-19 22:20:17,775 DEBUG : BROWSER_OUTPUT: Values: 96.0 95.0 95.0 95.0 96.0 95.0 95.0 95.0 95.0 95.0 22:20:18 INFO - 2015-11-19 22:20:17,775 DEBUG : BROWSER_OUTPUT: 22:20:18 INFO - 2015-11-19 22:20:17,775 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:60.90 Median:60.00 stddev:3.41 (5.7%) stddev-sans-first:3.61 22:20:18 INFO - 2015-11-19 22:20:17,775 DEBUG : BROWSER_OUTPUT: Values: 60.0 60.0 60.0 60.0 61.0 60.0 62.0 70.0 58.0 58.0 22:20:18 INFO - 2015-11-19 22:20:17,775 DEBUG : BROWSER_OUTPUT: 22:20:18 INFO - 2015-11-19 22:20:17,776 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:69.00 Median:69.00 stddev:1.15 (1.7%) stddev-sans-first:1.22 22:20:18 INFO - 2015-11-19 22:20:17,776 DEBUG : BROWSER_OUTPUT: Values: 69.0 68.0 69.0 68.0 69.0 69.0 69.0 69.0 72.0 68.0 22:20:18 INFO - 2015-11-19 22:20:17,776 DEBUG : BROWSER_OUTPUT: 22:20:18 INFO - 2015-11-19 22:20:17,776 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:83.60 Median:84.00 stddev:1.07 (1.3%) stddev-sans-first:0.97 22:20:18 INFO - 2015-11-19 22:20:17,776 DEBUG : BROWSER_OUTPUT: Values: 82.0 82.0 83.0 84.0 84.0 84.0 85.0 83.0 84.0 85.0 22:20:18 INFO - 2015-11-19 22:20:17,776 DEBUG : BROWSER_OUTPUT: 22:20:18 INFO - 2015-11-19 22:20:17,776 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:120.60 Median:121.00 stddev:5.42 (4.5%) stddev-sans-first:5.67 22:20:18 INFO - 2015-11-19 22:20:17,776 DEBUG : BROWSER_OUTPUT: Values: 118.0 117.0 132.0 119.0 116.0 125.0 113.0 120.0 122.0 124.0 22:20:18 INFO - 2015-11-19 22:20:17,776 DEBUG : BROWSER_OUTPUT: 22:20:18 INFO - 2015-11-19 22:20:17,776 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:144.30 Median:148.00 stddev:5.76 (3.9%) stddev-sans-first:5.78 22:20:18 INFO - 2015-11-19 22:20:17,776 DEBUG : BROWSER_OUTPUT: Values: 139.0 150.0 138.0 147.0 149.0 138.0 148.0 150.0 148.0 136.0 22:20:18 INFO - 2015-11-19 22:20:17,776 DEBUG : BROWSER_OUTPUT: 22:20:18 INFO - 2015-11-19 22:20:17,776 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.90 Median:67.00 stddev:0.88 (1.3%) stddev-sans-first:0.93 22:20:18 INFO - 2015-11-19 22:20:17,776 DEBUG : BROWSER_OUTPUT: Values: 67.0 66.0 68.0 66.0 66.0 67.0 66.0 68.0 67.0 68.0 22:20:18 INFO - 2015-11-19 22:20:17,776 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 22:20:18 INFO - 2015-11-19 22:20:17,776 DEBUG : BROWSER_OUTPUT: 22:20:20 INFO - 2015-11-19 22:20:20,360 INFO : Browser exited with error code: 0 22:20:20 INFO - 2015-11-19 22:20:20,414 INFO : Completed test kraken (00:01:11) 22:20:20 INFO - 2015-11-19 22:20:20,414 INFO : Starting test v8_7 22:20:20 INFO - 2015-11-19 22:20:20,414 DEBUG : operating with platform_type : linux_ 22:20:20 INFO - 2015-11-19 22:20:20,414 INFO : Initialising browser for v8_7 test... 22:20:20 INFO - 2015-11-19 22:20:20,420 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpOTwt2i/profile http://localhost:52052/getInfo.html 22:20:32 INFO - 2015-11-19 22:20:32,879 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 22:20:32 INFO - 2015-11-19 22:20:32,879 DEBUG : BROWSER_OUTPUT: colorDepth:24 22:20:32 INFO - 2015-11-19 22:20:32,879 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 22:20:32 INFO - 2015-11-19 22:20:32,879 DEBUG : BROWSER_OUTPUT: __metrics 22:20:33 INFO - 2015-11-19 22:20:33,675 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:20:39 INFO - 2015-11-19 22:20:39,912 INFO : Browser initialized. 22:20:39 INFO - 2015-11-19 22:20:39,912 INFO : Running cycle 1/1 for v8_7 test... 22:20:39 INFO - 2015-11-19 22:20:39,913 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpOTwt2i/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 22:20:51 INFO - 2015-11-19 22:20:51,613 DEBUG : BROWSER_OUTPUT: RSS: Main: 141778944 22:20:51 INFO - 2015-11-19 22:20:51,613 DEBUG : BROWSER_OUTPUT: 22:21:13 INFO - 2015-11-19 22:21:13,214 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52052/tests/v8_7/run.html (next: http://localhost:52052/tests/v8_7/run.html) 22:21:13 INFO - 2015-11-19 22:21:13,460 DEBUG : BROWSER_OUTPUT: RSS: Main: 616579072 22:21:13 INFO - 2015-11-19 22:21:13,460 DEBUG : BROWSER_OUTPUT: 22:21:13 INFO - 2015-11-19 22:21:13,461 DEBUG : BROWSER_OUTPUT: __start_tp_report 22:21:13 INFO - 2015-11-19 22:21:13,461 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 22:21:13 INFO - 2015-11-19 22:21:13,462 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 22:21:13 INFO - 2015-11-19 22:21:13,462 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 22:21:13 INFO - 2015-11-19 22:21:13,462 DEBUG : BROWSER_OUTPUT: |0;Richards;163.15875346712352 22:21:13 INFO - 2015-11-19 22:21:13,462 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;194.09937888198758 22:21:13 INFO - 2015-11-19 22:21:13,462 DEBUG : BROWSER_OUTPUT: |2;Encrypt;284.0102243680773 22:21:13 INFO - 2015-11-19 22:21:13,462 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5025 22:21:13 INFO - 2015-11-19 22:21:13,463 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1098.901098901099 22:21:13 INFO - 2015-11-19 22:21:13,463 DEBUG : BROWSER_OUTPUT: |5;Earley;780.64012490242 22:21:13 INFO - 2015-11-19 22:21:13,463 DEBUG : BROWSER_OUTPUT: |6;Boyer;12253.012048192772 22:21:13 INFO - 2015-11-19 22:21:13,463 DEBUG : BROWSER_OUTPUT: |7;RegExp;28055.555555555555 22:21:13 INFO - 2015-11-19 22:21:13,463 DEBUG : BROWSER_OUTPUT: |8;Splay;662.7296587926509 22:21:13 INFO - 2015-11-19 22:21:13,463 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4850.241545893719 22:21:13 INFO - 2015-11-19 22:21:13,464 DEBUG : BROWSER_OUTPUT: __end_tp_report 22:21:13 INFO - 2015-11-19 22:21:13,464 DEBUG : BROWSER_OUTPUT: __startTimestamp1448000473460__endTimestamp 22:21:13 INFO - 2015-11-19 22:21:13,464 DEBUG : BROWSER_OUTPUT: 22:21:13 INFO - 2015-11-19 22:21:13,464 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 22:21:13 INFO - 2015-11-19 22:21:13,464 DEBUG : BROWSER_OUTPUT: Number of tests: 10 22:21:13 INFO - 2015-11-19 22:21:13,465 DEBUG : BROWSER_OUTPUT: 22:21:13 INFO - 2015-11-19 22:21:13,465 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:163.16 Median:163.16 stddev:0.00 (0.0%) 22:21:13 INFO - 2015-11-19 22:21:13,465 DEBUG : BROWSER_OUTPUT: Values: 163.2 22:21:13 INFO - 2015-11-19 22:21:13,465 DEBUG : BROWSER_OUTPUT: 22:21:13 INFO - 2015-11-19 22:21:13,465 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:194.10 Median:194.10 stddev:0.00 (0.0%) 22:21:13 INFO - 2015-11-19 22:21:13,465 DEBUG : BROWSER_OUTPUT: Values: 194.1 22:21:13 INFO - 2015-11-19 22:21:13,466 DEBUG : BROWSER_OUTPUT: 22:21:13 INFO - 2015-11-19 22:21:13,466 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:284.01 Median:284.01 stddev:0.00 (0.0%) 22:21:13 INFO - 2015-11-19 22:21:13,466 DEBUG : BROWSER_OUTPUT: Values: 284.0 22:21:13 INFO - 2015-11-19 22:21:13,466 DEBUG : BROWSER_OUTPUT: 22:21:13 INFO - 2015-11-19 22:21:13,466 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5025.00 Median:5025.00 stddev:0.00 (0.0%) 22:21:13 INFO - 2015-11-19 22:21:13,467 DEBUG : BROWSER_OUTPUT: Values: 5025.0 22:21:13 INFO - 2015-11-19 22:21:13,467 DEBUG : BROWSER_OUTPUT: 22:21:13 INFO - 2015-11-19 22:21:13,467 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1098.90 Median:1098.90 stddev:0.00 (0.0%) 22:21:13 INFO - 2015-11-19 22:21:13,467 DEBUG : BROWSER_OUTPUT: Values: 1098.9 22:21:13 INFO - 2015-11-19 22:21:13,467 DEBUG : BROWSER_OUTPUT: 22:21:13 INFO - 2015-11-19 22:21:13,468 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:780.64 Median:780.64 stddev:0.00 (0.0%) 22:21:13 INFO - 2015-11-19 22:21:13,468 DEBUG : BROWSER_OUTPUT: Values: 780.6 22:21:13 INFO - 2015-11-19 22:21:13,468 DEBUG : BROWSER_OUTPUT: 22:21:13 INFO - 2015-11-19 22:21:13,468 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:12253.01 Median:12253.01 stddev:0.00 (0.0%) 22:21:13 INFO - 2015-11-19 22:21:13,468 DEBUG : BROWSER_OUTPUT: Values: 12253.0 22:21:13 INFO - 2015-11-19 22:21:13,469 DEBUG : BROWSER_OUTPUT: 22:21:13 INFO - 2015-11-19 22:21:13,469 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:28055.56 Median:28055.56 stddev:0.00 (0.0%) 22:21:13 INFO - 2015-11-19 22:21:13,469 DEBUG : BROWSER_OUTPUT: Values: 28055.6 22:21:13 INFO - 2015-11-19 22:21:13,469 DEBUG : BROWSER_OUTPUT: 22:21:13 INFO - 2015-11-19 22:21:13,469 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:662.73 Median:662.73 stddev:0.00 (0.0%) 22:21:13 INFO - 2015-11-19 22:21:13,469 DEBUG : BROWSER_OUTPUT: Values: 662.7 22:21:13 INFO - 2015-11-19 22:21:13,470 DEBUG : BROWSER_OUTPUT: 22:21:13 INFO - 2015-11-19 22:21:13,470 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4850.24 Median:4850.24 stddev:0.00 (0.0%) 22:21:13 INFO - 2015-11-19 22:21:13,470 DEBUG : BROWSER_OUTPUT: Values: 4850.2 22:21:13 INFO - 2015-11-19 22:21:13,470 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 22:21:13 INFO - 2015-11-19 22:21:13,470 DEBUG : BROWSER_OUTPUT: 22:21:15 INFO - 2015-11-19 22:21:15,000 INFO : Browser exited with error code: 0 22:21:15 INFO - 2015-11-19 22:21:15,017 INFO : Completed test v8_7 (00:00:54) 22:21:15 INFO - 2015-11-19 22:21:15,383 INFO : Completed test suite (00:21:42) 22:21:15 INFO - 2015-11-19 22:21:15,383 DEBUG : Working with test: dromaeo_css 22:21:15 INFO - 2015-11-19 22:21:15,383 DEBUG : Generating results file: dromaeo_css 22:21:15 INFO - 2015-11-19 22:21:15,385 DEBUG : Working with test: kraken 22:21:15 INFO - 2015-11-19 22:21:15,385 DEBUG : Generating results file: kraken 22:21:15 INFO - 2015-11-19 22:21:15,385 INFO : javascript benchmark 22:21:15 INFO - 2015-11-19 22:21:15,385 DEBUG : Working with test: v8_7 22:21:15 INFO - 2015-11-19 22:21:15,385 DEBUG : Generating results file: v8_7 22:21:15 INFO - 2015-11-19 22:21:15,386 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 22:21:15 INFO - 2015-11-19 22:21:15,436 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,201,35]] 22:21:15 INFO - 2015-11-19 22:21:15,436 DEBUG : process_Request line: dromaeo_css 6973.73 graph.html#tests=[[72,201,35]] 22:21:15 INFO - 2015-11-19 22:21:15,436 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 22:21:15 INFO - 2015-11-19 22:21:15,467 DEBUG : process_Request line: kraken 1495.90 graph.html#tests=[[232,201,35]] 22:21:15 INFO - 2015-11-19 22:21:15,467 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 22:21:15 INFO - 2015-11-19 22:21:15,506 DEBUG : process_Request line: v8_7 20718.35 graph.html#tests=[[230,201,35]] 22:21:15 INFO - 2015-11-19 22:21:15,508 INFO : javascript benchmark 22:21:15 INFO - 2015-11-19 22:21:15,511 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3140.387624413239, 3213.4215841148584, 3260.3968265870817, 3263.8857639982607, 3282.458394364929, 5184.585233181346, 5284.0752868248, 5383.865403364918, 5396.244525766391, 5490.835274941748, 5281.207818827178, 5331.57347412207, 5335.653182543132, 5392.973035134819, 5394.05604019297, 4885.804567817292, 4925.064237794825, 4934.111859865223, 4940.382452193476, 5002.899942001158, 4945.23348880924, 5049.520295571915, 5051.267566202899, 5055.848324550269, 5088.211327244283, 4817.470078291385, 4921.630877684152, 4939.259111133323, 4987.127252730794, 4988.825391111293, 4953.90092198154, 4968.975155124237, 4969.155243608595, 4971.900561988776, 4973.204287314049, 4842.15262329091, 4865.537773911473, 4918.336024636664, 4928.408590969071, 4932.901341973176, 5122.948770512322, 5129.12804823181, 5129.153689641204, 5138.203578445347, 5168.5606723428555, 5718.971405142989, 5729.0, 5730.398308177665, 5733.111367738007, 5739.713014349308, 5705.030144875381, 5772.07646776518, 5838.036723940587, 5842.415758424124, 5952.047672372443, 5476.342838859362, 5478.753456094485, 5478.780848766084, 5486.984907792032, 5543.334799824007, 5895.941040589625, 5949.137375080589, 5964.671943043088, 5976.133460648181, 5977.6114552553945, 5551.694656793915, 5663.093904975184, 5712.428757124254, 5725.885482290331, 5790.478856902899, 5832.795852145155, 5843.2403787507355, 5843.561732870052, 5847.3275573308765, 5901.76392944286, 5815.563832712563, 5818.301803783488, 5819.621724587888, 5820.679862607597, 5823.0, 5647.887042259132, 5677.971610141923, 5782.88434231313, 5794.362620111784, 5819.388964158787, 4478.0596074824, 4483.955160448354, 4525.185466616041, 4526.79629416677, 4531.320301954733, 3996.86010989614, 4000.699947503949, 4005.5794141615293, 4013.5585085640555, 4036.2129384769687, 5297.655652382583, 5411.134218525017, 5434.456554344613, 5475.561955043587, 5479.04116779562, 5756.740946657411, 5760.395158508296, 5763.106718458645, 5778.682172480554, 5871.060630299217, 5367.892642147135, 5415.83752487426, 5425.403205647375, 5433.1850222466155, 5448.237246785453, 4949.158643030693, 4967.975160124176, 5059.367579052619, 5088.0, 5104.259882317043, 5963.254593175853, 5967.791127310524, 5973.283206015219, 5973.820785376446, 5978.491828194478, 5750.6262092963825, 5757.395473475225, 5759.366469688247, 5761.625494342854, 5763.7406316715005, 5875.383084776208, 5950.613210141327, 5983.640981541122, 5984.102384642339, 6070.1501789750355, 5623.943760562342, 5664.065429204135, 5670.8015219467125, 5697.772089116389, 5742.684152371659, 5742.971285143548, 5763.394843541368, 5763.827085187451, 5765.250517432707, 5770.047942089508, 5386.461353864739, 5485.204645326485, 5627.606067575231, 5696.515796157373, 5742.310922689304, 5646.237757902631, 5654.180143879197, 5656.264685591012, 5657.066584013592, 5663.801766938137, 5387.299651045339, 5526.171074338881, 5572.554195664418, 5576.776928922797, 5586.497215250484, 5563.193336966036, 5631.521320687623, 5791.362950075404, 5796.42035796417, 5811.79658711943, 5477.507024367826, 5478.91781623284, 5482.616216864941, 5485.424030476743, 5494.0], "unit": "ms", "name": "dojo.html", "value": 5333.454255470203}, {"lowerIsBetter": false, "replicates": [586.9266341707287, 588.7792077970761, 592.354333776184, 594.8037147741243, 609.9786507472239, 31429.528557071662, 39978.800105999464, 40520.79739601298, 40605.390919136196, 40664.39003414944, 42907.3563896541, 43383.78308108455, 43397.13205735891, 43402.34896476555, 43447.56552434475, 7528.284812942762, 7641.1976742442075, 8755.781105472382, 8931.10688931105, 8936.687215947442, 10356.119729822974, 10637.840432393521, 10644.57421703131, 10647.84028239577, 10649.307794993301, 10422.843657345145, 10523.473826308693, 10528.210384221176, 10528.78942421151, 10539.209559283085, 7758.728444504443, 7954.801129971739, 10448.059674629281, 10597.417142057184, 10886.945565272123, 10172.287939844215, 10295.845562316572, 10296.536655850505, 10300.27898047137, 10301.53643086063, 30727.539086913715, 40029.0, 40525.79737101325, 40537.189256215, 40626.79686601578, 2838.6451693538306, 3298.7690861639694, 3361.96638033619, 3413.74396920232, 3561.8041007744564, 30128.397432051235, 30509.0, 30736.8463157685, 30832.53751193734, 31552.0, 3880.553736320303, 3916.4125381192766, 3916.941245881314, 3961.841526338943, 3974.066094467798, 273988.0, 274214.0, 274225.0, 274938.0, 275120.0, 58082.12876806851, 59809.0, 61510.38489615046, 62079.689601551705, 68412.657936711, 63261.36738632647, 63356.36643633505, 63576.36423635705, 63637.36362636407, 63698.36301636924, 16437.83562164387, 16496.587585310463, 16704.83295167057, 16710.498685039467, 16725.581860453585, 12802.871971280169, 12875.678108047374, 12882.871171288354, 12885.806712899313, 12901.483940642456, 20164.0, 20454.079566419547, 20656.896715516326, 20682.138607525394, 20734.79265207359, 7951.5626640534165, 8031.518108913484, 8083.797905052421, 8107.108218096005, 8168.183181681784, 975.7170420578095, 979.5298256836759, 981.7692842182081, 1001.9398836069713, 1090.1061129873585, 28387.71612283892, 29158.27104322409, 29300.267493312836, 29383.0, 31627.52558711621, 1033.5865653738565, 1037.600523798328, 1044.3316277582353, 1056.3767377247461, 1073.393532654048, 13560.59318220455, 13633.727325453436, 13771.311434428238, 13821.654458638615, 13925.442982280798, 314331.0, 316507.0, 317295.0, 318515.0, 319138.0, 51857.2221416679, 52022.47977520252, 52064.0, 52066.0, 52111.0, 1353.2354219865745, 1374.9931250343684, 1380.1581035568295, 1387.6877702516854, 1388.4931999820194, 24867.378315541533, 26902.32744181411, 27302.317442064108, 28996.42007159803, 29085.85457072701, 47334.763326184526, 48145.518544814106, 48548.2717759241, 48571.27143092786, 48667.75666121647, 260454.0, 262612.0, 262882.0, 263662.0, 263718.0, 28018.439631207668, 28391.716082838906, 32204.516932246504, 32318.515222272155, 32476.350472990882, 39458.80270598629, 41428.79285603673, 42318.0, 42336.0, 42352.36471452869, 35483.29033419369, 35796.284074317846, 36398.454023189144, 37022.44466333061, 37084.51661933492, 35632.28735425329, 35970.8201458991, 35987.560497579805, 36179.81910090433, 36600.63399366079, 33156.1710957228, 33895.0, 34234.315313693085, 34240.486392704624, 34247.657523424445, 31391.372172555963, 32237.51643725299, 33656.326873461905, 33661.3267734639, 33696.49455258124, 25066.122685705912, 25266.494670106127, 25455.618165727898, 25633.743662563134, 25789.097381591553], "unit": "ms", "name": "ext.html", "value": 18878.43154501683}, {"lowerIsBetter": false, "replicates": [345.36108199830335, 356.2732026665602, 360.0817914318488, 360.60873951762335, 363.7871844970692, 13673.111247768888, 13980.300984950763, 16335.183240837956, 16412.0, 16877.57806054849, 15770.448034318773, 15991.280392382341, 16654.750178747297, 16665.41671041514, 16685.666286674288, 4678.672492925497, 4804.0, 4826.3001864729595, 4828.830990915319, 4829.541193586604, 3633.5458067741533, 3703.0557207911943, 4848.927266091011, 5227.477252274761, 5378.704171270579, 5286.920696189561, 5303.390110137326, 5326.6005049621235, 5351.197320401932, 5361.892762144755, 5349.946500535003, 5583.302087239095, 5751.223584816038, 5794.5943783935145, 5814.302283725959, 5167.457416971201, 5184.662996905189, 5203.453637368098, 5205.349331333583, 5213.635045546814, 16699.582510437216, 20687.0690818912, 20918.5816283675, 21271.468213294636, 21317.893410533004, 1950.54162271866, 1987.6720341143694, 2073.1914553324214, 2078.9480262993393, 2085.0304608357187, 9516.286278529069, 9686.031396860328, 9927.056929591678, 11010.119190464744, 12808.359582020956, 1795.721663142202, 1808.1682426084017, 1831.1668190973076, 1881.8776779509287, 1889.3198448558508, 57473.425265747224, 58996.82006359892, 61438.69280653613, 61522.38477615211, 62184.378156218765, 10239.590416383262, 10292.992866390981, 10315.690529284133, 10320.793584128276, 10350.53422595985, 13588.79616805729, 13634.454621815017, 13676.247806370746, 13684.31578421075, 13687.520936767165, 7308.634568271672, 7342.5227360221415, 7351.77944661661, 7521.285477879593, 7607.619619019027, 7175.282471752887, 7209.459290553229, 7273.6726847292, 7339.633018349061, 7348.2284360142485, 4419.911601768011, 4486.685931984795, 4487.910241795146, 4532.841350552715, 4546.386237857913, 1727.1191692236798, 1773.3527262549076, 1795.2818872451123, 1801.4055361730598, 1819.8453131483973, 451.9548045195454, 967.5355829201882, 974.8342781727123, 1002.6540843409158, 1062.6440142552176, 10248.795024099625, 10450.68647940563, 10509.211809114347, 10509.474526273656, 10778.622748203776, 412.17770547757414, 422.38964696013966, 439.31028285591316, 452.7351499372904, 453.17974466216253, 5639.774409023676, 5733.168690539848, 5802.071668533014, 5842.620229685057, 5886.470217680429, 521083.0, 526130.0, 527695.0, 533720.0, 534759.0, 76412.61793691108, 80522.59738701386, 81280.18719812845, 82363.0, 82887.0, 1169.8011338072547, 1175.7295821960997, 1191.1007189571817, 1213.1144264686827, 1235.8022716365338, 15246.31391587359, 15401.845981540042, 15413.229338533252, 15465.536033919001, 15813.762793558337, 34054.48918266278, 34557.0, 34583.82708086444, 34896.47655285223, 34920.22350378603, 44523.777381112886, 45406.31890521579, 46033.30950035819, 48094.0, 48972.75513622409, 9170.266378689823, 9517.714468565953, 9642.325037247325, 9643.373180743229, 9652.71041868717, 11227.21409501327, 16322.836771632607, 16344.67310653804, 17023.574410639834, 17093.658126837145, 14488.492902748354, 14630.70738585201, 14665.120092794466, 14671.779923300946, 14693.463941901604, 14552.85447145515, 14620.780688289897, 14759.852401475848, 14898.1806000671, 15084.622884427537, 11719.648410547697, 15163.848361516244, 15248.0, 15317.540473785804, 15329.853820464921, 8659.653613855375, 9830.508474576385, 9836.458994755358, 9912.454814985245, 9918.652847150315, 10450.111740502143, 10564.049235568837, 12293.877061229274, 14175.291235438393, 14303.928480357532], "unit": "ms", "name": "jquery.html", "value": 8352.387140082123}, {"lowerIsBetter": false, "replicates": [1499.3702644889145, 1501.4519700309384, 1598.1074255597362, 1752.1677203328416, 1810.0176139323721, 6663.466922646189, 7048.894266585999, 7211.9639401802915, 7243.2032476427685, 7246.420286377091, 7483.438742094351, 7504.137024242214, 7531.096268447794, 7542.9245707542905, 7553.811154721135, 1949.8635095543318, 1981.375866602023, 2256.751757306699, 2270.2621647964397, 2275.306031660343, 2260.728712554496, 2288.6567014947723, 2307.1348244408346, 2307.8038366738847, 2308.3536609749212, 2231.1967691631, 2268.1947908492493, 2278.943026424336, 2279.076973825603, 2280.247518318951, 1974.2596526302636, 2008.4175589079223, 2232.029067355689, 2266.660000999855, 2271.954560908789, 2171.826253899684, 2263.4680850000236, 2265.275111964172, 2265.592193405186, 2270.818334533233, 7585.317321441097, 7689.38484921205, 7720.652570634279, 7722.343600793939, 7728.961355193244, 4527.569880861313, 4611.423572053493, 4614.700044497097, 4616.8153273869, 4619.3763841881255, 3246.821424821634, 3246.935061298761, 3288.408086544421, 3298.09302441828, 3306.636270010297, 1086.630545614487, 1922.6346994071082, 1930.8744931579402, 1932.2753967262277, 1940.262700173925, 10096.444695541742, 10138.188944884392, 10157.847632285522, 10170.898291017069, 10178.847317290247, 4117.8970525736495, 4130.256553820281, 4188.4136220929095, 4197.979010104991, 4263.680223983151, 8685.91314086851, 8693.391462597683, 8694.0, 8700.08649091849, 8711.215990560753, 4672.556107169813, 4690.03854209893, 4717.363155973968, 4719.268513380432, 4724.834630787975, 4343.978280108642, 4347.413099231627, 4349.325854492558, 4351.521332653406, 4356.106998065452, 3357.748168887343, 3383.678550537695, 3394.745394095453, 3405.659434056624, 3423.0415483664615, 1006.1498034161123, 1016.3749294184172, 1021.39737554843, 1038.9116925061303, 1041.4116024446164, 1371.9245441500814, 1381.8410882748412, 1405.57130075328, 1405.9156450612995, 1409.9224542650252, 6586.473082153416, 7229.132504099542, 7577.621118944031, 7596.734114305973, 7600.125985511626, 583.5739909865822, 590.4538302070567, 592.4904582059512, 629.8330942300294, 631.8136149835809, 5684.573656975744, 5738.0, 5740.856478587985, 5758.913616295675, 5765.250517432791, 8947.686830960885, 8967.148120928632, 9081.0, 9103.81792364149, 9123.863142052875, 8897.955510222408, 8920.197182253498, 9034.412763170372, 9047.547622618842, 9050.366474346733, 6846.075779769667, 7042.225355210922, 7048.541844780176, 7118.786436406916, 7119.786406407816, 6859.622720750406, 6861.348171923659, 6862.0, 6879.828004299932, 6880.965595171992, 7678.8080297993, 7939.404544659289, 8105.716299929474, 8115.0, 8122.5126492410645, 8154.103048664523, 8290.58547072656, 8330.416870818985, 8331.041930178108, 8340.124286950026, 6659.300773418721, 6888.138982627172, 6934.16789985205, 6937.340952609494, 6939.410150137093, 7234.891476627749, 7330.706771729071, 7333.0, 7333.303336183054, 7348.154962179417, 6830.385265326145, 6899.724011039703, 6965.407940325129, 6996.755113571001, 7054.929450705427, 6783.966080169567, 6788.2193547742645, 6892.172939247122, 6939.410150137295, 6954.652267386711, 6237.688115594293, 6404.1674582304, 6581.80254592363, 6841.521093523405, 6873.450123989969, 6358.523110766803, 6573.342665733579, 6599.208095028435, 6625.17185351831, 6628.237752658506, 6600.768973085919, 6650.700718467584, 6683.598984060972, 6683.83290417724, 6686.431653309523], "unit": "ms", "name": "mootools.html", "value": 4411.999232492124}, {"lowerIsBetter": false, "replicates": [324.57480700282633, 339.0455866735141, 344.95688038995127, 348.9441689329708, 354.62409845563707, 6073.878522429549, 6080.300765411979, 6095.146679464873, 6096.908546371808, 6099.6275837936555, 5991.011483105282, 6017.187679663244, 6020.698965051741, 6021.45806877381, 6030.33666296707, 4685.273782563691, 4702.98885739566, 4703.412073490814, 4706.247000479924, 4709.693869898463, 4586.793594288265, 4662.13750456165, 4685.625149987993, 4690.624750019991, 4694.953050469503, 4627.213373726458, 4628.652851036169, 4635.049814787961, 4635.327877457784, 4639.6752227344095, 4400.933985990213, 4478.798454069574, 4636.211843986531, 4662.97668511657, 4666.020135771492, 4029.9194016119804, 4094.3653733671326, 4124.628783409477, 4135.855245066408, 4136.937945930814, 5646.971765141189, 5675.772969081232, 5692.57305702074, 5704.458076482728, 5705.115707065412, 5079.517445842639, 5207.6875387476875, 5250.422453530108, 5396.64921780083, 5409.56723462122, 6357.618542887441, 6361.777337793202, 6365.8408539786415, 6389.744410223586, 6393.0, 4530.614897733697, 4532.909341813145, 4534.77326133692, 4535.160995215896, 4536.160810250114, 6536.313687062838, 6598.142241508621, 6630.204375474926, 6672.366125218096, 6672.699728512229, 4534.59188673021, 4539.84110556129, 4542.523035081335, 4543.704659197141, 4543.954560454419, 4569.520200378979, 4599.747013914267, 4599.977000115045, 4600.42494688164, 4601.746903920316, 5304.177852432879, 5305.071612467803, 5305.495977882095, 5310.230016647564, 5314.707691077027, 6292.528060395489, 6389.456896163878, 6437.485001199892, 6443.6455994920725, 6458.806235812933, 1664.4424117920632, 1684.9747253791204, 1685.3932584269653, 1685.9325626974783, 1687.5949772054619, 1103.8896110389057, 1144.1418935798151, 1150.1201580790703, 1163.8603367595942, 1171.6719318590808, 6243.157173781481, 6244.250689917239, 6246.250449946036, 6249.187605611241, 6251.718672659741, 6597.538172327891, 6656.101426307483, 6661.500387470959, 6666.266710661824, 6669.333066693292, 6082.482988945989, 6177.907331390033, 6240.375962403723, 6257.874842503215, 6258.280297765815, 3590.622984586581, 3592.173800026009, 3616.1863580694135, 3618.8371523281517, 3623.8550457981387, 6720.966395167993, 6739.258681545026, 6748.089007983957, 6749.156355455568, 6751.189857217068, 6541.542092053605, 6580.86838263232, 6788.389044985975, 6794.150731158606, 6794.830129246809, 6845.8973115403305, 6922.723091076401, 6928.757493487704, 6938.27148149437, 6960.825979350456, 6690.531662783558, 6695.598264104169, 6696.062551242732, 6696.062551242732, 6698.631575263407, 6474.2878283387845, 6600.933990660032, 6626.105475760711, 6631.502637302126, 6646.401823835685, 6919.515633905578, 6929.1684997800585, 6930.13373328334, 6933.826654333682, 6938.791836244921, 4666.906661866811, 4669.276262179367, 4669.696469729457, 4673.299005149255, 4675.111728771522, 6475.870482590228, 6620.63586502747, 6649.867002659823, 6655.600663960178, 6657.833554161185, 6480.125183100221, 6491.123698300669, 6514.413702766774, 6522.34776522344, 6523.217213934358, 6523.18460192476, 6524.739010439529, 6526.0, 6532.183477065367, 6541.149650545399, 6217.875642487215, 6386.297507274289, 6397.360263973565, 6402.0, 6407.327230640715, 6541.738330466728, 6556.688662267661, 6558.672066396756, 6559.704813283318, 6560.179977502812, 6339.904901426575, 6369.713362898773, 6390.808275751735, 6406.519511036598, 6412.839679008062], "unit": "ms", "name": "prototype.html", "value": 4874.741208827416}, {"lowerIsBetter": false, "replicates": [857.9442336248144, 863.3222920007795, 867.3668222197795, 881.95590220489, 884.261641529323, 13568.932155339222, 13829.515966941146, 13905.443782248723, 13924.58226253214, 13983.161010339387, 12846.614601561969, 14081.929590352034, 14173.0, 14182.361793719281, 14198.78701819471, 697.8185671725337, 823.3618945317382, 828.4904783558129, 829.0134739659785, 831.2601784411878, 698.1203683358979, 803.0564087197549, 804.2279411764713, 812.9349652027853, 828.0684230240979, 843.616154649636, 843.6498852976008, 844.5312851367488, 849.4818160921833, 868.7958329792493, 721.8231533274355, 730.5762657658545, 843.1652663862762, 867.9522626255554, 881.6209030117047, 619.0188551146439, 619.3651507205105, 619.5663035874906, 636.6212103798279, 651.3323843060853, 13475.19148851072, 13493.797593036112, 13593.32033398336, 13598.660033499242, 13606.455741770318, 11441.885581144164, 11947.223430476992, 12041.217320874115, 12685.492580296777, 12781.721827817237, 10247.692569222936, 10316.277860549764, 10320.122789562896, 10326.01902819231, 10449.26855120142, 3350.9832450837835, 3377.645347238529, 3385.2890892912274, 3427.0, 3481.8433170507133, 49252.75373623109, 51091.744541277054, 51160.48839511594, 51635.0, 51752.74123629396, 9572.712818615453, 9605.279604029725, 9613.90386096144, 9642.084002019797, 9716.514174291256, 17628.118594070245, 17687.115644217996, 17719.0, 17768.822311776716, 17797.555061123574, 6944.756933507303, 7076.540024898365, 7090.290970902868, 7180.31786980236, 7277.8544429111125, 4406.537313582092, 4423.159599676052, 4423.225935461346, 4443.8000289986385, 4484.349769283435, 3260.5924259467565, 3277.770556061053, 3285.4086264472626, 3288.0, 3338.0, 567.234233784396, 586.4633860018121, 597.6653074278418, 606.5966132521912, 613.2763339259716, 680.2585182151479, 680.391050010238, 695.6834640238679, 706.2337363960161, 708.9078419805495, 8537.359698022548, 8776.429532080521, 9036.186743193144, 9183.908160918305, 9730.172935300438, 508.3569284854662, 616.6207782213907, 651.1274891645218, 697.341012742953, 782.2803021220377, 3872.6514613684903, 3975.1254723960683, 3993.72043956926, 4207.305794543866, 4223.746575205498, 57567.0, 57626.0, 57842.71078644664, 58319.70840145857, 61897.69051154715, 49908.0, 50401.49598504041, 50680.74659626752, 50693.74653126785, 51210.0, 45292.773536132765, 46272.30591541129, 46363.0, 46710.0, 46968.5303146971, 8345.624446900025, 8503.574821259035, 8855.60149793248, 8917.866232006654, 9009.954950225207, 32621.18447038843, 33914.152146196546, 34193.14517137092, 34247.31505369928, 34887.65112348844, 42216.577834221265, 42752.78623606862, 42932.35601466043, 43371.0, 43473.56526434822, 10949.781004379709, 10996.945015274872, 11003.394813285346, 11051.115910726961, 11071.72320691989, 12098.274103553815, 12124.416423925593, 12164.148509604243, 12315.568955086528, 12428.254304741744, 11552.59565915189, 11825.70435739079, 11893.524259029542, 12212.450439730412, 12488.625341239778, 11254.493547790533, 11553.133514986577, 11592.47833847462, 11616.651500455, 11986.820197697216, 7790.0, 11328.830067549157, 11355.318680879174, 11490.655280341603, 11883.049356051322, 9612.726820780512, 9857.654982075594, 10019.735993890501, 10210.846837297298, 10387.37675739458, 9486.92062413169, 9894.29302214047, 9945.303828732209, 9948.701538953843, 9992.550335234786], "unit": "ms", "name": "yui.html", "value": 6358.8528213443315}], "name": "dromaeo_css", "value": 6973.726468621273}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [109.0, 112.0, 103.0, 112.0, 113.0, 111.0, 99.0, 112.0, 109.0, 108.0], "unit": "ms", "name": "ai-astar", "value": 108.8}, {"lowerIsBetter": true, "replicates": [153.0, 134.0, 146.0, 157.0, 125.0, 154.0, 148.0, 125.0, 186.0, 128.0], "unit": "ms", "name": "audio-beat-detection", "value": 145.6}, {"lowerIsBetter": true, "replicates": [161.0, 161.0, 161.0, 161.0, 159.0, 161.0, 160.0, 161.0, 160.0, 160.0], "unit": "ms", "name": "audio-dft", "value": 160.5}, {"lowerIsBetter": true, "replicates": [73.0, 72.0, 93.0, 94.0, 72.0, 72.0, 72.0, 101.0, 90.0, 72.0], "unit": "ms", "name": "audio-fft", "value": 81.1}, {"lowerIsBetter": true, "replicates": [90.0, 91.0, 146.0, 90.0, 89.0, 90.0, 136.0, 97.0, 91.0, 135.0], "unit": "ms", "name": "audio-oscillator", "value": 105.5}, {"lowerIsBetter": true, "replicates": [109.0, 109.0, 109.0, 109.0, 109.0, 109.0, 110.0, 110.0, 109.0, 109.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 109.2}, {"lowerIsBetter": true, "replicates": [144.0, 146.0, 144.0, 145.0, 144.0, 145.0, 144.0, 145.0, 145.0, 145.0], "unit": "ms", "name": "imaging-darkroom", "value": 144.7}, {"lowerIsBetter": true, "replicates": [96.0, 95.0, 95.0, 95.0, 96.0, 95.0, 95.0, 95.0, 95.0, 95.0], "unit": "ms", "name": "imaging-desaturate", "value": 95.2}, {"lowerIsBetter": true, "replicates": [60.0, 60.0, 60.0, 60.0, 61.0, 60.0, 62.0, 70.0, 58.0, 58.0], "unit": "ms", "name": "json-parse-financial", "value": 60.9}, {"lowerIsBetter": true, "replicates": [69.0, 68.0, 69.0, 68.0, 69.0, 69.0, 69.0, 69.0, 72.0, 68.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 69.0}, {"lowerIsBetter": true, "replicates": [82.0, 82.0, 83.0, 84.0, 84.0, 84.0, 85.0, 83.0, 84.0, 85.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 83.6}, {"lowerIsBetter": true, "replicates": [118.0, 117.0, 132.0, 119.0, 116.0, 125.0, 113.0, 120.0, 122.0, 124.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 120.6}, {"lowerIsBetter": true, "replicates": [139.0, 150.0, 138.0, 147.0, 149.0, 138.0, 148.0, 150.0, 148.0, 136.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 144.3}, {"lowerIsBetter": true, "replicates": [67.0, 66.0, 68.0, 66.0, 66.0, 67.0, 66.0, 68.0, 67.0, 68.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 66.9}], "name": "kraken", "value": 1495.8999999999999}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [163.15875346712352], "unit": "score", "name": "Richards", "value": 216.36595800000006}, {"lowerIsBetter": false, "replicates": [194.09937888198758], "unit": "score", "name": "DeltaBlue", "value": 340.63993600000003}, {"lowerIsBetter": false, "replicates": [284.0102243680773], "unit": "score", "name": "Encrypt", "value": 937.2233010000001}, {"lowerIsBetter": false, "replicates": [5025.0], "unit": "score", "name": "Decrypt", "value": 52.971343283582044}, {"lowerIsBetter": false, "replicates": [1098.901098901099], "unit": "score", "name": "RayTrace", "value": 673.3899900000001}, {"lowerIsBetter": false, "replicates": [780.64012490242], "unit": "score", "name": "Earley", "value": 853.7391030000001}, {"lowerIsBetter": false, "replicates": [12253.012048192772], "unit": "score", "name": "Boyer", "value": 54.391768928220245}, {"lowerIsBetter": false, "replicates": [28055.555555555555], "unit": "score", "name": "RegExp", "value": 32.470752475247544}, {"lowerIsBetter": false, "replicates": [662.7296587926509], "unit": "score", "name": "Splay", "value": 122.96265742574262}, {"lowerIsBetter": false, "replicates": [4850.241545893719], "unit": "score", "name": "NavierStokes", "value": 305.9641434262948}], "name": "v8_7", "value": 20718.352260278472}]} 22:21:15 INFO - RETURN: dromaeo_css: 6973.73 22:21:15 INFO - RETURN: kraken: 1495.90 22:21:15 INFO - RETURN: v8_7: 20718.35 22:21:15 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,201,35]]", "result": "20718.35"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,201,35]]", "result": "1495.90"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,201,35]]", "result": "6973.73"}}} 22:21:15 INFO - Return code: 0 22:21:15 INFO - # TBPL SUCCESS # 22:21:15 INFO - Running post-action listener: _resource_record_post_action 22:21:15 INFO - Running post-run listener: _resource_record_post_run 22:21:16 INFO - Total resource usage - Wall time: 1325s; CPU: 13.0%; Read bytes: 4096; Write bytes: 503341056; Read time: 2904; Write time: 6168908 22:21:16 INFO - install - Wall time: 23s; CPU: 21.0%; Read bytes: 0; Write bytes: 125931520; Read time: 0; Write time: 1397616 22:21:16 INFO - run-tests - Wall time: 1303s; CPU: 13.0%; Read bytes: 4096; Write bytes: 377409536; Read time: 2904; Write time: 4771292 22:21:16 INFO - Running post-run listener: _upload_blobber_files 22:21:16 INFO - Blob upload gear active. 22:21:16 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 22:21:16 INFO - Copying logs to upload dir... 22:21:16 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1371.186876 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 22 mins, 51 secs) (at 2015-11-19 22:21:16.255631) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-19 22:21:16.259512) ========= 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=256b35f542ca8bede9e27f1f00000291-1447998187.971045-1073784541 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/Z2BrdRaaTa-ne8G6NhFIkQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.010082 build_url: 'https://queue.taskcluster.net/v1/task/Z2BrdRaaTa-ne8G6NhFIkQ/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-19 22:21:16.311446) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-19 22:21:16.311798) ========= 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=256b35f542ca8bede9e27f1f00000291-1447998187.971045-1073784541 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004626 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-19 22:21:16.361938) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-19 22:21:16.362271) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-19 22:21:16.362562) ========= ========= Total master_lag: 0.25 =========