builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-009 starttime: 1447264295.24 results: success (0) buildid: 20151111083010 builduid: 7c91d06766cd4160a83b6b7c9b1a6074 revision: e402ff476e1b9ff5764aeec44442ab3213c2efc6 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-11-11 09:51:35.236568) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-11-11 09:51:35.237077) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-11 09:51:35.237364) ========= bash -c pwd in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'pwd'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=a732b360c9c0c9a4a8cfc42c000001d9-1447263937.475703-2145690893 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006684 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-11 09:51:35.260834) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-11 09:51:35.261153) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-11 09:51:35.275949) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-11 09:51:35.276307) ========= rm -rf properties in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'properties'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=a732b360c9c0c9a4a8cfc42c000001d9-1447263937.475703-2145690893 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004588 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-11 09:51:35.325350) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-11 09:51:35.325616) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-11 09:51:35.325950) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-11 09:51:35.326217) ========= bash -c 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py' in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=a732b360c9c0c9a4a8cfc42c000001d9-1447263937.475703-2145690893 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-11-11 09:51:35-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 222M=0s 2015-11-11 09:51:35 (222 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.289385 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-11 09:51:35.629124) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-11 09:51:35.629574) ========= rm -rf scripts in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=a732b360c9c0c9a4a8cfc42c000001d9-1447263937.475703-2145690893 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017466 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-11 09:51:35.683888) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-11 09:51:35.684252) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev e402ff476e1b9ff5764aeec44442ab3213c2efc6 --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/fx-team --rev e402ff476e1b9ff5764aeec44442ab3213c2efc6 --destination scripts --debug'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=a732b360c9c0c9a4a8cfc42c000001d9-1447263937.475703-2145690893 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-11-11 09:51:35,770 truncating revision to first 12 chars 2015-11-11 09:51:35,770 Setting DEBUG logging. 2015-11-11 09:51:35,770 attempt 1/10 2015-11-11 09:51:35,770 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/e402ff476e1b?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-11-11 09:51:36,124 unpacking tar archive at: fx-team-e402ff476e1b/testing/mozharness/ program finished with exit code 0 elapsedTime=0.716448 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-11 09:51:36.413629) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-11 09:51:36.414047) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-11 09:51:36.423211) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-11 09:51:36.423799) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-11 09:51:36.424279) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 57 secs) (at 2015-11-11 09:51:36.424626) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 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-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--system-bits', '64', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test-pgo/buildprops.json PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=a732b360c9c0c9a4a8cfc42c000001d9-1447263937.475703-2145690893 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 09:51:36 INFO - MultiFileLogger online at 20151111 09:51:36 in /builds/slave/test-pgo 09:51:36 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 09:51:36 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 09:51:36 INFO - {'append_to_log': False, 09:51:36 INFO - 'base_work_dir': '/builds/slave/test-pgo', 09:51:36 INFO - 'blob_upload_branch': 'Fx-Team', 09:51:36 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 09:51:36 INFO - 'branch': 'Fx-Team', 09:51:36 INFO - 'buildbot_json_path': 'buildprops.json', 09:51:36 INFO - 'config_files': ('talos/linux_config.py',), 09:51:36 INFO - 'default_actions': ('clobber', 09:51:36 INFO - 'read-buildbot-config', 09:51:36 INFO - 'download-and-extract', 09:51:36 INFO - 'populate-webroot', 09:51:36 INFO - 'create-virtualenv', 09:51:36 INFO - 'install', 09:51:36 INFO - 'run-tests'), 09:51:36 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:51:36 INFO - 'download_minidump_stackwalk': True, 09:51:36 INFO - 'download_symbols': 'ondemand', 09:51:36 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:51:36 INFO - 'tooltool.py': '/tools/tooltool.py', 09:51:36 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:51:36 INFO - '/tools/misc-python/virtualenv.py')}, 09:51:36 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:51:36 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:51:36 INFO - 'installer_path': 'installer.exe', 09:51:36 INFO - 'log_level': 'info', 09:51:36 INFO - 'log_name': 'talos', 09:51:36 INFO - 'log_to_console': True, 09:51:36 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 09:51:36 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 09:51:36 INFO - 'opt_config_files': (), 09:51:36 INFO - 'pip_index': False, 09:51:36 INFO - 'sps_profile': False, 09:51:36 INFO - 'sps_profile_interval': 0, 09:51:36 INFO - 'suite': 'dromaeojs-e10s', 09:51:36 INFO - 'system_bits': '64', 09:51:36 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:51:36 INFO - 'title': 'talos-linux64-ix-009', 09:51:36 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:51:36 INFO - 'use_talos_json': True, 09:51:36 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 09:51:36 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:51:36 INFO - 'work_dir': 'build'} 09:51:36 INFO - ##### 09:51:36 INFO - ##### Running clobber step. 09:51:36 INFO - ##### 09:51:36 INFO - Running pre-action listener: _resource_record_pre_action 09:51:36 INFO - Running main action method: clobber 09:51:36 INFO - rmtree: /builds/slave/test-pgo/build 09:51:36 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 09:51:37 INFO - Running post-action listener: _resource_record_post_action 09:51:37 INFO - ##### 09:51:37 INFO - ##### Running read-buildbot-config step. 09:51:37 INFO - ##### 09:51:37 INFO - Running pre-action listener: _resource_record_pre_action 09:51:37 INFO - Running main action method: read_buildbot_config 09:51:37 INFO - Using buildbot properties: 09:51:37 INFO - { 09:51:37 INFO - "properties": { 09:51:37 INFO - "buildnumber": 321, 09:51:37 INFO - "product": "firefox", 09:51:37 INFO - "script_repo_revision": "production", 09:51:37 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 09:51:37 INFO - "repository": "", 09:51:37 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs-e10s", 09:51:37 INFO - "buildid": "20151111083010", 09:51:37 INFO - "slavename": "talos-linux64-ix-009", 09:51:37 INFO - "pgo_build": "True", 09:51:37 INFO - "basedir": "/builds/slave/test-pgo", 09:51:37 INFO - "project": "", 09:51:37 INFO - "platform": "ubuntu64_hw", 09:51:37 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 09:51:37 INFO - "slavebuilddir": "test", 09:51:37 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 09:51:37 INFO - "branch": "fx-team", 09:51:37 INFO - "repo_path": "integration/fx-team", 09:51:37 INFO - "stage_platform": "linux64-pgo", 09:51:37 INFO - "builduid": "7c91d06766cd4160a83b6b7c9b1a6074", 09:51:37 INFO - "revision": "e402ff476e1b9ff5764aeec44442ab3213c2efc6" 09:51:37 INFO - }, 09:51:37 INFO - "sourcestamp": { 09:51:37 INFO - "repository": "", 09:51:37 INFO - "hasPatch": false, 09:51:37 INFO - "project": "", 09:51:37 INFO - "branch": "fx-team-linux64-pgo-talos", 09:51:37 INFO - "changes": [ 09:51:37 INFO - { 09:51:37 INFO - "category": null, 09:51:37 INFO - "files": [ 09:51:37 INFO - { 09:51:37 INFO - "url": null, 09:51:37 INFO - "name": "https://queue.taskcluster.net/v1/task/sOPdHRtjTQGttforyY7Bhg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2" 09:51:37 INFO - } 09:51:37 INFO - ], 09:51:37 INFO - "repository": "", 09:51:37 INFO - "rev": "e402ff476e1b9ff5764aeec44442ab3213c2efc6", 09:51:37 INFO - "who": "sendchange", 09:51:37 INFO - "when": 1447264257, 09:51:37 INFO - "number": 6649476, 09:51:37 INFO - "comments": "", 09:51:37 INFO - "project": "", 09:51:37 INFO - "at": "Wed 11 Nov 2015 09:50:57", 09:51:37 INFO - "branch": "fx-team-linux64-pgo-talos", 09:51:37 INFO - "revlink": "", 09:51:37 INFO - "properties": [ 09:51:37 INFO - [ 09:51:37 INFO - "buildid", 09:51:37 INFO - "20151111083010", 09:51:37 INFO - "Change" 09:51:37 INFO - ], 09:51:37 INFO - [ 09:51:37 INFO - "builduid", 09:51:37 INFO - "7c91d06766cd4160a83b6b7c9b1a6074", 09:51:37 INFO - "Change" 09:51:37 INFO - ], 09:51:37 INFO - [ 09:51:37 INFO - "pgo_build", 09:51:37 INFO - "True", 09:51:37 INFO - "Change" 09:51:37 INFO - ] 09:51:37 INFO - ], 09:51:37 INFO - "revision": "e402ff476e1b9ff5764aeec44442ab3213c2efc6" 09:51:37 INFO - } 09:51:37 INFO - ], 09:51:37 INFO - "revision": "e402ff476e1b9ff5764aeec44442ab3213c2efc6" 09:51:37 INFO - } 09:51:37 INFO - } 09:51:37 INFO - Found installer url https://queue.taskcluster.net/v1/task/sOPdHRtjTQGttforyY7Bhg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2. 09:51:37 INFO - Running post-action listener: _resource_record_post_action 09:51:37 INFO - ##### 09:51:37 INFO - ##### Running download-and-extract step. 09:51:37 INFO - ##### 09:51:37 INFO - Running pre-action listener: _resource_record_pre_action 09:51:37 INFO - Running main action method: download_and_extract 09:51:37 INFO - mkdir: /builds/slave/test-pgo/build/tests 09:51:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:51:37 INFO - https://queue.taskcluster.net/v1/task/sOPdHRtjTQGttforyY7Bhg/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 09:51:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/sOPdHRtjTQGttforyY7Bhg/artifacts/public/build/test_packages.json 09:51:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/sOPdHRtjTQGttforyY7Bhg/artifacts/public/build/test_packages.json 09:51:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/sOPdHRtjTQGttforyY7Bhg/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 09:51:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/sOPdHRtjTQGttforyY7Bhg/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 09:51:37 INFO - Downloaded 1302 bytes. 09:51:37 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 09:51:37 INFO - Using the following test package requirements: 09:51:37 INFO - {u'common': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 09:51:37 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 09:51:37 INFO - u'firefox-45.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 09:51:37 INFO - u'jittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 09:51:37 INFO - u'jsshell-linux-x86_64.zip'], 09:51:37 INFO - u'mochitest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 09:51:37 INFO - u'firefox-45.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 09:51:37 INFO - u'mozbase': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 09:51:37 INFO - u'reftest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 09:51:37 INFO - u'firefox-45.0a1.en-US.linux-x86_64.reftest.tests.zip'], 09:51:37 INFO - u'talos': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 09:51:37 INFO - u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'], 09:51:37 INFO - u'web-platform': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 09:51:37 INFO - u'firefox-45.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 09:51:37 INFO - u'webapprt': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 09:51:37 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 09:51:37 INFO - u'firefox-45.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 09:51:37 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 09:51:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:51:37 INFO - https://queue.taskcluster.net/v1/task/sOPdHRtjTQGttforyY7Bhg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 09:51:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/sOPdHRtjTQGttforyY7Bhg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 09:51:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/sOPdHRtjTQGttforyY7Bhg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 09:51:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/sOPdHRtjTQGttforyY7Bhg/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 09:51:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/sOPdHRtjTQGttforyY7Bhg/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 09:51:41 INFO - Downloaded 22438130 bytes. 09:51:41 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 09:51:41 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 09:51:41 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 09:51:42 INFO - Return code: 0 09:51:42 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 09:51:42 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')]} 09:51:42 INFO - https://queue.taskcluster.net/v1/task/sOPdHRtjTQGttforyY7Bhg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 09:51:42 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/sOPdHRtjTQGttforyY7Bhg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 09:51:42 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/sOPdHRtjTQGttforyY7Bhg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 09:51:42 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/sOPdHRtjTQGttforyY7Bhg/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 09:51:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/sOPdHRtjTQGttforyY7Bhg/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 09:51:45 INFO - Downloaded 22438130 bytes. 09:51:45 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 09:51:45 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 09:51:45 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 09:51:46 INFO - Return code: 0 09:51:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:51:46 INFO - https://queue.taskcluster.net/v1/task/sOPdHRtjTQGttforyY7Bhg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 09:51:46 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/sOPdHRtjTQGttforyY7Bhg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 09:51:46 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/sOPdHRtjTQGttforyY7Bhg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 09:51:46 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/sOPdHRtjTQGttforyY7Bhg/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 09:51:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/sOPdHRtjTQGttforyY7Bhg/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 09:51:47 INFO - Downloaded 11131693 bytes. 09:51:47 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 09:51:47 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 09:51:47 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 09:51:47 INFO - Return code: 0 09:51:47 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')]} 09:51:47 INFO - https://queue.taskcluster.net/v1/task/sOPdHRtjTQGttforyY7Bhg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 09:51:47 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/sOPdHRtjTQGttforyY7Bhg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 09:51:47 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/sOPdHRtjTQGttforyY7Bhg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 09:51:47 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/sOPdHRtjTQGttforyY7Bhg/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 09:51:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/sOPdHRtjTQGttforyY7Bhg/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 09:51:49 INFO - Downloaded 57160729 bytes. 09:51:49 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/sOPdHRtjTQGttforyY7Bhg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 09:51:49 INFO - mkdir: /builds/slave/test-pgo/properties 09:51:49 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 09:51:49 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 09:51:49 INFO - Contents: 09:51:49 INFO - build_url:https://queue.taskcluster.net/v1/task/sOPdHRtjTQGttforyY7Bhg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 09:51:49 INFO - Running post-action listener: _resource_record_post_action 09:51:49 INFO - Running post-action listener: set_extra_try_arguments 09:51:49 INFO - ##### 09:51:49 INFO - ##### Running populate-webroot step. 09:51:49 INFO - ##### 09:51:49 INFO - Running pre-action listener: _resource_record_pre_action 09:51:49 INFO - Running main action method: populate_webroot 09:51:49 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:51:49 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:51:49 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 09:51:49 INFO - '../fennec_ids.txt'], 09:51:49 INFO - 'tests': ['tcheck2']}, 09:51:49 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:51:49 INFO - '--tppagecycles', 09:51:49 INFO - '7'], 09:51:49 INFO - 'tests': ['tsvgm']}}, 09:51:49 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 09:51:49 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 09:51:49 INFO - 'tests': ['tresize', 'tcanvasmark']}, 09:51:49 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 09:51:49 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 09:51:49 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 09:51:49 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:51:49 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:51:49 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:51:49 INFO - 'talos_options': ['--e10s'], 09:51:49 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:51:49 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:51:49 INFO - 'tests': ['damp', 'tps']}, 09:51:49 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:51:49 INFO - 'talos_options': ['--e10s'], 09:51:49 INFO - 'tests': ['damp', 'tps']}, 09:51:49 INFO - 'g3': {'tests': ['dromaeo_dom']}, 09:51:49 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:51:49 INFO - 'other': {'tests': ['a11yr', 09:51:49 INFO - 'ts_paint', 09:51:49 INFO - 'tpaint', 09:51:49 INFO - 'sessionrestore', 09:51:49 INFO - 'sessionrestore_no_auto_restore']}, 09:51:49 INFO - 'other-e10s': {'talos_options': ['--e10s'], 09:51:49 INFO - 'tests': ['a11yr', 09:51:49 INFO - 'ts_paint', 09:51:49 INFO - 'tpaint', 09:51:49 INFO - 'sessionrestore', 09:51:49 INFO - 'sessionrestore_no_auto_restore']}, 09:51:49 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 09:51:49 INFO - 'tests': ['a11yr', 09:51:49 INFO - 'ts_paint', 09:51:49 INFO - 'tpaint', 09:51:49 INFO - 'sessionrestore', 09:51:49 INFO - 'sessionrestore_no_auto_restore']}, 09:51:49 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 09:51:49 INFO - 'tests': ['a11yr', 09:51:49 INFO - 'ts_paint', 09:51:49 INFO - 'tpaint', 09:51:49 INFO - 'sessionrestore', 09:51:49 INFO - 'sessionrestore_no_auto_restore']}, 09:51:49 INFO - 'other_l64': {'tests': ['a11yr', 09:51:49 INFO - 'ts_paint', 09:51:49 INFO - 'tpaint', 09:51:49 INFO - 'sessionrestore', 09:51:49 INFO - 'sessionrestore_no_auto_restore']}, 09:51:49 INFO - 'other_nol64': {'tests': ['a11yr', 09:51:49 INFO - 'ts_paint', 09:51:49 INFO - 'tpaint', 09:51:49 INFO - 'sessionrestore', 09:51:49 INFO - 'sessionrestore_no_auto_restore']}, 09:51:49 INFO - 'svgr': {'tests': ['tsvgx', 09:51:49 INFO - 'tsvgr_opacity', 09:51:49 INFO - 'tart', 09:51:49 INFO - 'tscrollx', 09:51:49 INFO - 'cart']}, 09:51:49 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 09:51:49 INFO - 'tests': ['tsvgx', 09:51:49 INFO - 'tsvgr_opacity', 09:51:49 INFO - 'tart', 09:51:49 INFO - 'tscrollx', 09:51:49 INFO - 'cart']}, 09:51:49 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:51:49 INFO - 'tests': ['tp5o']}, 09:51:49 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:51:49 INFO - 'talos_options': ['--e10s'], 09:51:49 INFO - 'tests': ['tp5o']}, 09:51:49 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:51:49 INFO - 'talos_options': ['--xperf_path', 09:51:49 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:51:49 INFO - 'tests': ['tp5n']}, 09:51:49 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:51:49 INFO - 'talos_options': ['--e10s', 09:51:49 INFO - '--xperf_path', 09:51:49 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:51:49 INFO - 'tests': ['tp5n']}}, 09:51:49 INFO - 'talos.zip': {'path': '', 09:51:49 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:51:49 INFO - Running post-action listener: _resource_record_post_action 09:51:49 INFO - ##### 09:51:49 INFO - ##### Running create-virtualenv step. 09:51:49 INFO - ##### 09:51:49 INFO - Running pre-action listener: _resource_record_pre_action 09:51:49 INFO - Running main action method: create_virtualenv 09:51:49 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 09:51:49 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 09:51:49 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 09:51:49 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:51:49 INFO - Using real prefix '/usr' 09:51:49 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 09:51:49 INFO - Installing distribute.............................................................................................................................................................................................done. 09:51:51 INFO - Installing pip.................done. 09:51:51 INFO - Return code: 0 09:51:51 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 09:51:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:51:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:51:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:51:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:51:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:51:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:51:51 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f3db3a18c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x294f6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a103d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a998c0>, '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 0x2a46420>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a468b0>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'a732b360c9c0c9a4a8cfc42c000001d9-1447263937.475703-2145690893', '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 09:51:51 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test-pgo/build 09:51:51 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 09:51:51 INFO - Using env: {'DISPLAY': ':0', 09:51:51 INFO - 'HOME': '/home/cltbld', 09:51:51 INFO - 'LANG': 'en_US.UTF-8', 09:51:51 INFO - 'LANGUAGE': 'en_US:en', 09:51:51 INFO - 'LOGNAME': 'cltbld', 09:51:51 INFO - 'MAIL': '/var/mail/cltbld', 09:51:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:51:51 INFO - 'MOZ_NO_REMOTE': '1', 09:51:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:51:51 INFO - 'NO_EM_RESTART': '1', 09:51:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:51:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 09:51:51 INFO - 'PWD': '/builds/slave/test-pgo', 09:51:51 INFO - 'SHELL': '/bin/bash', 09:51:51 INFO - 'SHLVL': '1', 09:51:51 INFO - 'TERM': 'linux', 09:51:51 INFO - 'TMOUT': '86400', 09:51:51 INFO - 'USER': 'cltbld', 09:51:51 INFO - 'XDG_SESSION_COOKIE': 'a732b360c9c0c9a4a8cfc42c000001d9-1447263937.475703-2145690893', 09:51:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:51:51 INFO - '_': '/tools/buildbot/bin/python'} 09:51:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:51:51 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 09:51:51 INFO - Cleaning up... 09:51:51 INFO - Return code: 0 09:51:51 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 09:51:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:51:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:51:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:51:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:51:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:51:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:51:51 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f3db3a18c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x294f6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a103d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a998c0>, '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 0x2a46420>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a468b0>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'a732b360c9c0c9a4a8cfc42c000001d9-1447263937.475703-2145690893', '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 09:51:51 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test-pgo/build 09:51:51 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 09:51:51 INFO - Using env: {'DISPLAY': ':0', 09:51:51 INFO - 'HOME': '/home/cltbld', 09:51:51 INFO - 'LANG': 'en_US.UTF-8', 09:51:51 INFO - 'LANGUAGE': 'en_US:en', 09:51:51 INFO - 'LOGNAME': 'cltbld', 09:51:51 INFO - 'MAIL': '/var/mail/cltbld', 09:51:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:51:51 INFO - 'MOZ_NO_REMOTE': '1', 09:51:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:51:51 INFO - 'NO_EM_RESTART': '1', 09:51:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:51:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 09:51:51 INFO - 'PWD': '/builds/slave/test-pgo', 09:51:51 INFO - 'SHELL': '/bin/bash', 09:51:51 INFO - 'SHLVL': '1', 09:51:51 INFO - 'TERM': 'linux', 09:51:51 INFO - 'TMOUT': '86400', 09:51:51 INFO - 'USER': 'cltbld', 09:51:51 INFO - 'XDG_SESSION_COOKIE': 'a732b360c9c0c9a4a8cfc42c000001d9-1447263937.475703-2145690893', 09:51:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:51:51 INFO - '_': '/tools/buildbot/bin/python'} 09:51:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:51:52 INFO - Downloading/unpacking psutil>=0.7.1 09:51:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:51:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:51:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:51:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:51:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:51:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:51:53 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 09:51:53 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 09:51:53 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 09:51:53 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:51:53 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:51:53 INFO - Installing collected packages: psutil 09:51:53 INFO - Running setup.py install for psutil 09:51:54 INFO - building 'psutil._psutil_linux' extension 09:51:54 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 09:51:54 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 09:51:54 INFO - building 'psutil._psutil_posix' extension 09:51:54 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 09:51:54 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 09:51:54 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:51:54 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:51:54 INFO - Successfully installed psutil 09:51:54 INFO - Cleaning up... 09:51:54 INFO - Return code: 0 09:51:54 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 09:51:54 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')]} 09:51:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:51:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:51:54 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')]} 09:51:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:51:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:51:54 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 0x7f3db3a18c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x294f6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a103d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a998c0>, '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 0x2a46420>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a468b0>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'a732b360c9c0c9a4a8cfc42c000001d9-1447263937.475703-2145690893', '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 09:51:54 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 09:51:54 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 09:51:54 INFO - Using env: {'DISPLAY': ':0', 09:51:54 INFO - 'HOME': '/home/cltbld', 09:51:54 INFO - 'LANG': 'en_US.UTF-8', 09:51:54 INFO - 'LANGUAGE': 'en_US:en', 09:51:54 INFO - 'LOGNAME': 'cltbld', 09:51:54 INFO - 'MAIL': '/var/mail/cltbld', 09:51:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:51:54 INFO - 'MOZ_NO_REMOTE': '1', 09:51:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:51:54 INFO - 'NO_EM_RESTART': '1', 09:51:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:51:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 09:51:54 INFO - 'PWD': '/builds/slave/test-pgo', 09:51:54 INFO - 'SHELL': '/bin/bash', 09:51:54 INFO - 'SHLVL': '1', 09:51:54 INFO - 'TERM': 'linux', 09:51:54 INFO - 'TMOUT': '86400', 09:51:54 INFO - 'USER': 'cltbld', 09:51:54 INFO - 'XDG_SESSION_COOKIE': 'a732b360c9c0c9a4a8cfc42c000001d9-1447263937.475703-2145690893', 09:51:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:51:54 INFO - '_': '/tools/buildbot/bin/python'} 09:51:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:51:54 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 09:51:54 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 09:51:54 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 09:51:54 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 09:51:54 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 09:51:54 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 09:51:54 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 09:51:56 INFO - Downloading mozsystemmonitor-0.0.tar.gz 09:51:56 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 09:51:56 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:51:56 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 09:51:56 INFO - Installing collected packages: mozsystemmonitor 09:51:56 INFO - Running setup.py install for mozsystemmonitor 09:51:56 INFO - Successfully installed mozsystemmonitor 09:51:56 INFO - Cleaning up... 09:51:56 INFO - Return code: 0 09:51:56 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 09:51: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')]} 09:51:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:51:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:51: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')]} 09:51:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:51:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:51: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', '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 0x7f3db3a18c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x294f6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a103d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a998c0>, '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 0x2a46420>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a468b0>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'a732b360c9c0c9a4a8cfc42c000001d9-1447263937.475703-2145690893', '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 09:51: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', 'blobuploader==1.2.4'] in /builds/slave/test-pgo/build 09:51: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 blobuploader==1.2.4 09:51:56 INFO - Using env: {'DISPLAY': ':0', 09:51:56 INFO - 'HOME': '/home/cltbld', 09:51:56 INFO - 'LANG': 'en_US.UTF-8', 09:51:56 INFO - 'LANGUAGE': 'en_US:en', 09:51:56 INFO - 'LOGNAME': 'cltbld', 09:51:56 INFO - 'MAIL': '/var/mail/cltbld', 09:51:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:51:56 INFO - 'MOZ_NO_REMOTE': '1', 09:51:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:51:56 INFO - 'NO_EM_RESTART': '1', 09:51:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:51:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 09:51:56 INFO - 'PWD': '/builds/slave/test-pgo', 09:51:56 INFO - 'SHELL': '/bin/bash', 09:51:56 INFO - 'SHLVL': '1', 09:51:56 INFO - 'TERM': 'linux', 09:51:56 INFO - 'TMOUT': '86400', 09:51:56 INFO - 'USER': 'cltbld', 09:51:56 INFO - 'XDG_SESSION_COOKIE': 'a732b360c9c0c9a4a8cfc42c000001d9-1447263937.475703-2145690893', 09:51:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:51:56 INFO - '_': '/tools/buildbot/bin/python'} 09:51:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:51:56 INFO - Downloading/unpacking blobuploader==1.2.4 09:51: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 09:51: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 09:51: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 09:51: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 09:51: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 09:51: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 09:51:58 INFO - Downloading blobuploader-1.2.4.tar.gz 09:51:58 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 09:51:58 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:51:58 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:51: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 09:51: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 09:51: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 09:51: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 09:51: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 09:51: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 09:51:58 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 09:51:58 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 09:51:58 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:51: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 09:51: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 09:51: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 09:51: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 09:51: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 09:51: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 09:51:59 INFO - Downloading docopt-0.6.1.tar.gz 09:51:59 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 09:51:59 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 09:51:59 INFO - Installing collected packages: blobuploader, requests, docopt 09:51:59 INFO - Running setup.py install for blobuploader 09:51:59 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:51:59 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 09:51:59 INFO - Running setup.py install for requests 09:51:59 INFO - Running setup.py install for docopt 09:51:59 INFO - Successfully installed blobuploader requests docopt 09:51:59 INFO - Cleaning up... 09:51:59 INFO - Return code: 0 09:51:59 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 09:51:59 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')]} 09:51:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:51:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:51:59 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')]} 09:51:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:51:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:51:59 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 0x7f3db3a18c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x294f6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a103d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a998c0>, '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 0x2a46420>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a468b0>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'a732b360c9c0c9a4a8cfc42c000001d9-1447263937.475703-2145690893', '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 09:51:59 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 09:51:59 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 09:51:59 INFO - Using env: {'DISPLAY': ':0', 09:51:59 INFO - 'HOME': '/home/cltbld', 09:51:59 INFO - 'LANG': 'en_US.UTF-8', 09:51:59 INFO - 'LANGUAGE': 'en_US:en', 09:51:59 INFO - 'LOGNAME': 'cltbld', 09:51:59 INFO - 'MAIL': '/var/mail/cltbld', 09:51:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:51:59 INFO - 'MOZ_NO_REMOTE': '1', 09:51:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:51:59 INFO - 'NO_EM_RESTART': '1', 09:51:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:51:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 09:51:59 INFO - 'PWD': '/builds/slave/test-pgo', 09:51:59 INFO - 'SHELL': '/bin/bash', 09:51:59 INFO - 'SHLVL': '1', 09:51:59 INFO - 'TERM': 'linux', 09:51:59 INFO - 'TMOUT': '86400', 09:51:59 INFO - 'USER': 'cltbld', 09:51:59 INFO - 'XDG_SESSION_COOKIE': 'a732b360c9c0c9a4a8cfc42c000001d9-1447263937.475703-2145690893', 09:51:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:51:59 INFO - '_': '/tools/buildbot/bin/python'} 09:52:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:52:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 09:52:00 INFO - Running setup.py (path:/tmp/pip-SBg0i_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 09:52:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 09:52:00 INFO - Running setup.py (path:/tmp/pip-oPuh8C-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 09:52:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 09:52:00 INFO - Running setup.py (path:/tmp/pip-N958QH-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 09:52:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 09:52:00 INFO - Running setup.py (path:/tmp/pip-dZYTD3-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 09:52:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 09:52:00 INFO - Running setup.py (path:/tmp/pip-ccsUvW-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 09:52:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 09:52:00 INFO - Running setup.py (path:/tmp/pip-1AC2YO-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 09:52:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 09:52:00 INFO - Running setup.py (path:/tmp/pip-XQuh3m-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 09:52:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 09:52:00 INFO - Running setup.py (path:/tmp/pip-i8uXRL-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 09:52:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 09:52:00 INFO - Running setup.py (path:/tmp/pip-D6TJMP-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 09:52:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 09:52:00 INFO - Running setup.py (path:/tmp/pip-pfPdFa-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 09:52:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 09:52:00 INFO - Running setup.py (path:/tmp/pip-nmrTPF-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 09:52:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 09:52:00 INFO - Running setup.py (path:/tmp/pip-IBm8qf-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 09:52:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 09:52:00 INFO - Running setup.py (path:/tmp/pip-lbrLCk-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 09:52:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 09:52:00 INFO - Running setup.py (path:/tmp/pip-Taanvc-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 09:52:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 09:52:01 INFO - Running setup.py (path:/tmp/pip-EMZk95-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 09:52:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 09:52:01 INFO - Running setup.py (path:/tmp/pip-Ne3iTR-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 09:52:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 09:52:01 INFO - Running setup.py (path:/tmp/pip-AbNe7K-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 09:52:01 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:52:01 INFO - Running setup.py install for manifestparser 09:52:01 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 09:52:01 INFO - Running setup.py install for mozcrash 09:52:01 INFO - Running setup.py install for mozdebug 09:52:01 INFO - Running setup.py install for mozdevice 09:52:01 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 09:52:01 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 09:52:01 INFO - Running setup.py install for mozfile 09:52:01 INFO - Running setup.py install for mozhttpd 09:52:01 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 09:52:01 INFO - Running setup.py install for mozinfo 09:52:01 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 09:52:01 INFO - Running setup.py install for mozInstall 09:52:02 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 09:52:02 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 09:52:02 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 09:52:02 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 09:52:02 INFO - Running setup.py install for mozleak 09:52:02 INFO - Running setup.py install for mozlog 09:52:02 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 09:52:02 INFO - Running setup.py install for moznetwork 09:52:02 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 09:52:02 INFO - Running setup.py install for mozprocess 09:52:02 INFO - Running setup.py install for mozprofile 09:52:02 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 09:52:02 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 09:52:02 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 09:52:02 INFO - Running setup.py install for mozrunner 09:52:02 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 09:52:02 INFO - Running setup.py install for mozscreenshot 09:52:02 INFO - Running setup.py install for moztest 09:52:02 INFO - Running setup.py install for mozversion 09:52:03 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 09:52:03 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:52:03 INFO - Cleaning up... 09:52:03 INFO - Return code: 0 09:52:03 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 09:52:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:52:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:52:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:52:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:52:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:52:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:52:03 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f3db3a18c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x294f6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a103d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a998c0>, '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 0x2a46420>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a468b0>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'a732b360c9c0c9a4a8cfc42c000001d9-1447263937.475703-2145690893', '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 09:52:03 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/config 09:52:03 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 09:52:03 INFO - Using env: {'DISPLAY': ':0', 09:52:03 INFO - 'HOME': '/home/cltbld', 09:52:03 INFO - 'LANG': 'en_US.UTF-8', 09:52:03 INFO - 'LANGUAGE': 'en_US:en', 09:52:03 INFO - 'LOGNAME': 'cltbld', 09:52:03 INFO - 'MAIL': '/var/mail/cltbld', 09:52:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:52:03 INFO - 'MOZ_NO_REMOTE': '1', 09:52:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:52:03 INFO - 'NO_EM_RESTART': '1', 09:52:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:52:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 09:52:03 INFO - 'PWD': '/builds/slave/test-pgo', 09:52:03 INFO - 'SHELL': '/bin/bash', 09:52:03 INFO - 'SHLVL': '1', 09:52:03 INFO - 'TERM': 'linux', 09:52:03 INFO - 'TMOUT': '86400', 09:52:03 INFO - 'USER': 'cltbld', 09:52:03 INFO - 'XDG_SESSION_COOKIE': 'a732b360c9c0c9a4a8cfc42c000001d9-1447263937.475703-2145690893', 09:52:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:52:03 INFO - '_': '/tools/buildbot/bin/python'} 09:52:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:52:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 09:52:03 INFO - Running setup.py (path:/tmp/pip-RtPckk-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 09:52:03 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)) 09:52:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 09:52:03 INFO - Running setup.py (path:/tmp/pip-gHwZ1u-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 09:52:03 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)) 09:52:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 09:52:03 INFO - Running setup.py (path:/tmp/pip-Kw2kJO-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 09:52:03 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)) 09:52:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 09:52:03 INFO - Running setup.py (path:/tmp/pip-x8Qbau-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 09:52:03 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)) 09:52:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 09:52:03 INFO - Running setup.py (path:/tmp/pip-ZUrtvk-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 09:52:03 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)) 09:52:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 09:52:03 INFO - Running setup.py (path:/tmp/pip-JjBom9-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 09:52:03 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)) 09:52:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 09:52:03 INFO - Running setup.py (path:/tmp/pip-6tTi9Q-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 09:52:03 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)) 09:52:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 09:52:03 INFO - Running setup.py (path:/tmp/pip-W8CEIY-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 09:52:03 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)) 09:52:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 09:52:03 INFO - Running setup.py (path:/tmp/pip-0z7vAm-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 09:52:03 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)) 09:52:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 09:52:03 INFO - Running setup.py (path:/tmp/pip-tRZSGX-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 09:52:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.0 from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 09:52:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 09:52:04 INFO - Running setup.py (path:/tmp/pip-ejO7vT-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 09:52:04 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 11)) 09:52:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 09:52:04 INFO - Running setup.py (path:/tmp/pip-VQIVah-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 09:52:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 12)) 09:52:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 09:52:04 INFO - Running setup.py (path:/tmp/pip-AdVWxp-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 09:52:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.27 from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 13)) 09:52:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 09:52:04 INFO - Running setup.py (path:/tmp/pip-xkV9p9-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 09:52:04 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)) 09:52:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 09:52:04 INFO - Running setup.py (path:/tmp/pip-y4GweD-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 09:52:04 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)) 09:52:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 09:52:04 INFO - Running setup.py (path:/tmp/pip-lEZxxs-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 09:52:04 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)) 09:52:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 09:52:04 INFO - Running setup.py (path:/tmp/pip-nRWtwo-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 09:52:04 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)) 09:52:04 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)) 09:52:04 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)) 09:52:04 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)) 09:52:04 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)) 09:52:04 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)) 09:52:04 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.0->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 09:52:04 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 09:52:04 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 09:52:04 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 09:52:04 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 09:52:04 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 09:52:04 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 09:52:06 INFO - Downloading blessings-1.5.1.tar.gz 09:52:06 INFO - Storing download in cache at /builds/slave/test-pgo/build/venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblessings-1.5.1.tar.gz 09:52:06 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 09:52:06 INFO - Installing collected packages: blessings 09:52:06 INFO - Running setup.py install for blessings 09:52:06 INFO - Successfully installed blessings 09:52:06 INFO - Cleaning up... 09:52:06 INFO - Return code: 0 09:52:06 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 09:52:06 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 09:52:06 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 09:52:06 INFO - Reading from file tmpfile_stdout 09:52:06 INFO - Current package versions: 09:52:06 INFO - argparse == 1.2.1 09:52:06 INFO - blessings == 1.5.1 09:52:06 INFO - blobuploader == 1.2.4 09:52:06 INFO - docopt == 0.6.1 09:52:06 INFO - manifestparser == 1.1 09:52:06 INFO - mozInstall == 1.12 09:52:06 INFO - mozcrash == 0.16 09:52:06 INFO - mozdebug == 0.1 09:52:06 INFO - mozdevice == 0.47 09:52:06 INFO - mozfile == 1.2 09:52:06 INFO - mozhttpd == 0.7 09:52:06 INFO - mozinfo == 0.9 09:52:06 INFO - mozleak == 0.1 09:52:06 INFO - mozlog == 3.0 09:52:06 INFO - moznetwork == 0.27 09:52:06 INFO - mozprocess == 0.22 09:52:06 INFO - mozprofile == 0.27 09:52:06 INFO - mozrunner == 6.11 09:52:06 INFO - mozscreenshot == 0.1 09:52:06 INFO - mozsystemmonitor == 0.0 09:52:06 INFO - moztest == 0.7 09:52:06 INFO - mozversion == 1.4 09:52:06 INFO - psutil == 3.1.1 09:52:06 INFO - requests == 1.2.3 09:52:06 INFO - wsgiref == 0.1.2 09:52:06 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 09:52:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:52:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:52:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:52:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:52:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:52:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:52:06 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-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 0x7f3db3a18c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x294f6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a103d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a998c0>, '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 0x2a46420>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a468b0>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build/tests/talos', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'a732b360c9c0c9a4a8cfc42c000001d9-1447263937.475703-2145690893', '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 09:52:06 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 09:52:06 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 09:52:06 INFO - Using env: {'DISPLAY': ':0', 09:52:06 INFO - 'HOME': '/home/cltbld', 09:52:06 INFO - 'LANG': 'en_US.UTF-8', 09:52:06 INFO - 'LANGUAGE': 'en_US:en', 09:52:06 INFO - 'LOGNAME': 'cltbld', 09:52:06 INFO - 'MAIL': '/var/mail/cltbld', 09:52:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:52:06 INFO - 'MOZ_NO_REMOTE': '1', 09:52:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:52:06 INFO - 'NO_EM_RESTART': '1', 09:52:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:52:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 09:52:06 INFO - 'PWD': '/builds/slave/test-pgo', 09:52:06 INFO - 'SHELL': '/bin/bash', 09:52:06 INFO - 'SHLVL': '1', 09:52:06 INFO - 'TERM': 'linux', 09:52:06 INFO - 'TMOUT': '86400', 09:52:06 INFO - 'USER': 'cltbld', 09:52:06 INFO - 'XDG_SESSION_COOKIE': 'a732b360c9c0c9a4a8cfc42c000001d9-1447263937.475703-2145690893', 09:52:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:52:06 INFO - '_': '/tools/buildbot/bin/python'} 09:52:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:52:06 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)) 09:52:06 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)) 09:52:06 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)) 09:52:06 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)) 09:52:06 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)) 09:52:06 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)) 09:52:06 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)) 09:52:06 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)) 09:52: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.15->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 09:52: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 mozhttpd>=0.7->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 3)) 09:52:06 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)) 09:52:06 INFO - Cleaning up... 09:52:06 INFO - Return code: 0 09:52:06 INFO - Running post-action listener: _resource_record_post_action 09:52:06 INFO - Running post-action listener: _start_resource_monitoring 09:52:06 INFO - Starting resource monitoring. 09:52:06 INFO - ##### 09:52:06 INFO - ##### Running install step. 09:52:06 INFO - ##### 09:52:06 INFO - Running pre-action listener: _resource_record_pre_action 09:52:06 INFO - Running main action method: install 09:52:06 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 09:52:06 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 09:52:07 INFO - Reading from file tmpfile_stdout 09:52:07 INFO - Detecting whether we're running mozinstall >=1.0... 09:52:07 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 09:52:07 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 09:52:07 INFO - Reading from file tmpfile_stdout 09:52:07 INFO - Output received: 09:52:07 INFO - Usage: mozinstall [options] installer 09:52:07 INFO - Options: 09:52:07 INFO - -h, --help show this help message and exit 09:52:07 INFO - -d DEST, --destination=DEST 09:52:07 INFO - Directory to install application into. [default: 09:52:07 INFO - "/builds/slave/test-pgo"] 09:52:07 INFO - --app=APP Application being installed. [default: firefox] 09:52:07 INFO - mkdir: /builds/slave/test-pgo/build/application 09:52:07 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'] 09:52:07 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 09:52:21 INFO - Reading from file tmpfile_stdout 09:52:21 INFO - Output received: 09:52:21 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 09:52:21 INFO - Running post-action listener: _resource_record_post_action 09:52:21 INFO - ##### 09:52:21 INFO - ##### Running run-tests step. 09:52:21 INFO - ##### 09:52:21 INFO - Running pre-action listener: _resource_record_pre_action 09:52:21 INFO - Running main action method: run_tests 09:52:21 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 09:52:21 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 09:52:21 INFO - Python 2.7.3 09:52:21 INFO - Return code: 0 09:52:21 INFO - grabbing minidump binary from tooltool 09:52:21 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')]} 09:52:21 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 0x2a998c0>, '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 0x2a46420>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a468b0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 09:52:21 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 09:52:21 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 09:52:21 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:52:21 INFO - Return code: 0 09:52:21 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 09:52:21 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 09:52:21 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 09:52:21 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 09:52:21 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 09:52:21 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/sOPdHRtjTQGttforyY7Bhg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-009', '--webServer', 'localhost'] in /builds/slave/test-pgo/build 09:52:21 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --debug --branchName Fx-Team --suite dromaeojs-e10s --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/sOPdHRtjTQGttforyY7Bhg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-009 --webServer localhost 09:52:21 INFO - Using env: {'DISPLAY': ':0', 09:52:21 INFO - 'HOME': '/home/cltbld', 09:52:21 INFO - 'LANG': 'en_US.UTF-8', 09:52:21 INFO - 'LANGUAGE': 'en_US:en', 09:52:21 INFO - 'LOGNAME': 'cltbld', 09:52:21 INFO - 'MAIL': '/var/mail/cltbld', 09:52:21 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 09:52:21 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 09:52:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:52:21 INFO - 'MOZ_NO_REMOTE': '1', 09:52:21 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 09:52:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:52:21 INFO - 'NO_EM_RESTART': '1', 09:52:21 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:52:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 09:52:21 INFO - 'PWD': '/builds/slave/test-pgo', 09:52:21 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 09:52:21 INFO - 'SHELL': '/bin/bash', 09:52:21 INFO - 'SHLVL': '1', 09:52:21 INFO - 'TERM': 'linux', 09:52:21 INFO - 'TMOUT': '86400', 09:52:21 INFO - 'USER': 'cltbld', 09:52:21 INFO - 'XDG_SESSION_COOKIE': 'a732b360c9c0c9a4a8cfc42c000001d9-1447263937.475703-2145690893', 09:52:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:52:21 INFO - '_': '/tools/buildbot/bin/python'} 09:52:21 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/sOPdHRtjTQGttforyY7Bhg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-009', '--webServer', 'localhost'] with output_timeout 3600 09:52:21 INFO - mozversion INFO | application_buildid: 20151111083010 09:52:21 INFO - mozversion INFO | application_changeset: e402ff476e1b9ff5764aeec44442ab3213c2efc6 09:52:21 INFO - mozversion INFO | application_display_name: Nightly 09:52:21 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:52:21 INFO - mozversion INFO | application_name: Firefox 09:52:21 INFO - mozversion INFO | application_remotingname: firefox 09:52:21 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/fx-team 09:52:21 INFO - mozversion INFO | application_vendor: Mozilla 09:52:21 INFO - mozversion INFO | application_version: 45.0a1 09:52:21 INFO - mozversion INFO | platform_buildid: 20151111083010 09:52:21 INFO - mozversion INFO | platform_changeset: e402ff476e1b9ff5764aeec44442ab3213c2efc6 09:52:21 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/fx-team 09:52:21 INFO - mozversion INFO | platform_version: 45.0a1 09:52:21 INFO - 2015-11-11 09:52:21,780 DEBUG : using testdate: 1447264341 09:52:21 INFO - 2015-11-11 09:52:21,781 DEBUG : actual date: 1447264341 09:52:21 INFO - 2015-11-11 09:52:21,789 INFO : starting webserver on 'localhost:34455' 09:52:21 INFO - 2015-11-11 09:52:21,790 INFO : Starting test suite talos-linux64-ix-009.e 09:52:21 INFO - 2015-11-11 09:52:21,790 INFO : Starting test dromaeo_css 09:52:21 INFO - 2015-11-11 09:52:21,790 DEBUG : operating with platform_type : linux_ 09:52:21 INFO - 2015-11-11 09:52:21,790 INFO : Initialising browser for dromaeo_css test... 09:52:21 INFO - 2015-11-11 09:52:21,797 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpx4LFxc/profile http://localhost:34455/getInfo.html 09:52:27 INFO - 2015-11-11 09:52:27,460 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 09:52:27 INFO - 2015-11-11 09:52:27,460 DEBUG : BROWSER_OUTPUT: colorDepth:24 09:52:27 INFO - 2015-11-11 09:52:27,460 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 09:52:27 INFO - 2015-11-11 09:52:27,460 DEBUG : BROWSER_OUTPUT: __metrics 09:52:28 INFO - 2015-11-11 09:52:28,453 INFO : Browser initialized. 09:52:28 INFO - 2015-11-11 09:52:28,454 INFO : Running cycle 1/1 for dromaeo_css test... 09:52:28 INFO - 2015-11-11 09:52:28,454 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpx4LFxc/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 09:52:40 INFO - 2015-11-11 09:52:40,251 DEBUG : BROWSER_OUTPUT: RSS: Main: 139309056 09:52:40 INFO - 2015-11-11 09:52:40,252 DEBUG : BROWSER_OUTPUT: 09:53:29 INFO - 2015-11-11 09:53:29,900 DEBUG : BROWSER_OUTPUT: 1447264409893 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] 09:55:39 INFO - 2015-11-11 09:55:39,209 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:34455/tests/dromaeo/cssquery-dojo.html (next: http://localhost:34455/tests/dromaeo/cssquery-ext.html) 09:55:40 INFO - 2015-11-11 09:55:40,359 DEBUG : BROWSER_OUTPUT: RSS: Main: 147648512 09:55:40 INFO - 2015-11-11 09:55:40,359 DEBUG : BROWSER_OUTPUT: 09:58:42 INFO - 2015-11-11 09:58:42,283 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:34455/tests/dromaeo/cssquery-ext.html (next: http://localhost:34455/tests/dromaeo/cssquery-jquery.html) 09:58:42 INFO - 2015-11-11 09:58:42,869 DEBUG : BROWSER_OUTPUT: RSS: Main: 140787712 09:58:42 INFO - 2015-11-11 09:58:42,869 DEBUG : BROWSER_OUTPUT: 10:01:44 INFO - 2015-11-11 10:01:44,497 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:34455/tests/dromaeo/cssquery-jquery.html (next: http://localhost:34455/tests/dromaeo/cssquery-mootools.html) 10:01:45 INFO - 2015-11-11 10:01:45,078 DEBUG : BROWSER_OUTPUT: RSS: Main: 141414400 10:01:45 INFO - 2015-11-11 10:01:45,079 DEBUG : BROWSER_OUTPUT: 10:04:46 INFO - 2015-11-11 10:04:46,681 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:34455/tests/dromaeo/cssquery-mootools.html (next: http://localhost:34455/tests/dromaeo/cssquery-prototype.html) 10:04:47 INFO - 2015-11-11 10:04:47,283 DEBUG : BROWSER_OUTPUT: RSS: Main: 139710464 10:04:47 INFO - 2015-11-11 10:04:47,283 DEBUG : BROWSER_OUTPUT: 10:07:49 INFO - 2015-11-11 10:07:49,544 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:34455/tests/dromaeo/cssquery-prototype.html (next: http://localhost:34455/tests/dromaeo/cssquery-yui.html) 10:07:50 INFO - 2015-11-11 10:07:50,166 DEBUG : BROWSER_OUTPUT: RSS: Main: 140001280 10:07:50 INFO - 2015-11-11 10:07:50,166 DEBUG : BROWSER_OUTPUT: 10:10:52 INFO - 2015-11-11 10:10:52,696 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:34455/tests/dromaeo/cssquery-yui.html (next: http://localhost:34455/tests/dromaeo/cssquery-dojo.html) 10:10:52 INFO - 2015-11-11 10:10:52,946 DEBUG : BROWSER_OUTPUT: RSS: Main: 142651392 10:10:52 INFO - 2015-11-11 10:10:52,946 DEBUG : BROWSER_OUTPUT: 10:10:52 INFO - 2015-11-11 10:10:52,947 DEBUG : BROWSER_OUTPUT: __start_tp_report 10:10:52 INFO - 2015-11-11 10:10:52,948 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 10:10:52 INFO - 2015-11-11 10:10:52,948 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 10:10:52 INFO - 2015-11-11 10:10:52,948 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 10:10:52 INFO - 2015-11-11 10:10:52,951 DEBUG : BROWSER_OUTPUT: |0;dojo.html;3226.9677303226968;3335.4496508076168;3359.6304406515296;3376.3584918865413;3381.814000229988;5370.087085195516;5522.088855338874;5534.2252084708125;5541.63979341343;5559.916601250984;5441.972790136044;5483.067878460662;5517.503424691777;5542.0301447246775;5559.805406810752;5007.298978143054;5079.111155547765;5132.435432102466;5157.793688252485;5158.587313014949;5080.339555857733;5158.845234642967;5167.509086636783;5172.19830926207;5197.116490196676;4924.4090709115135;4951.331570238026;4951.653384263103;5033.471485494007;5045.949540504585;5032;5039.697618142924;5050.116229659795;5075;5096.643234973553;5016.724080175589;5042.924356134661;5046.394432668103;5047.116754567936;5068.265101560253;5012.1980483122525;5141.820036298712;5144.485551444863;5214.713190774506;5215.348081489814;5930.05119180929;5974.253218347707;5978.461938425519;5988.940110598882;5995.1906492623375;5798.7100644968;5995.880082398327;6005.249343832021;6006.039033754579;6015.09773533969;5465.4261302563455;5523.889522209533;5529.861753456155;5529.944700553024;5548.916766248469;6082.75668973245;6089.056196289582;6101.005087479836;6118.1128736332985;6139.553468857771;5855.355910849803;5895.852603684856;5911.113333000085;5920.845435140192;5940.940590594038;5671.6597004179885;5824.155497452845;5872.500837428781;5972.820815375546;6006.579539432285;5931.1992880960515;6011.068284415923;6017.939820601826;6020.157177995085;6028.306744724325;5986.880262394815;5992.490638295706;5994.07091900756;6009.609375390585;6023.367546407651;4393.472783266028;4472.44094488189;4475.888102797391;4520.683552151384;4577.221872281653;4050.6556942659613;4059.0867054913;4078.6940979426663;4128.896777580524;4140.855070072533;5391.137418013099;5750.971245143747;5760.0783874579865;5774.595778295563;5775.422457754191;5830.591858569859;5884.676342801187;5945.851353716192;5971.492423144082;6003.7898673546215;5610.719464026783;5639.0977443609645;5644;5660.632058916157;5686.630369026;4995.475475075137;5098.796048158107;5169.043726910533;5188.11801993662;5189.221616757441;6046.2139921809885;6116.061877111514;6132.600268413531;6134.834601026089;6140.565599444434;6010.368911264429;6015.157877897185;6016.548758843017;6021.066734656135;6069.180660610761;5845.18167456548;5969.492593129633;5995.250593675791;6239.4696450800375;6263;5889.293284805851;5890.145928840208;5898.852528686817;5905.084711869667;5929.814037192665;5932.614380065282;5934.554908381802;5937.465628093492;5941.673207973603;5945.672987985702;5625.071863142535;5741.741621626953;5748.45389687979;5814.098814683731;5882.676452794966;5666.490015898589;5873.676947767743;5885.61743486672;5887.558433117619;5903.085021821625;5744.138379243147;5774.220480235114;5790.131480277992;5790.507806836466;5791.507721843691;5626.718664066862;5752.511036561772;5761.48146666802;5851.941480585139;5880.735366908414;5677.914831277617;5700.287464066992;5720.914186287126;5723.942760572341;5725.055365864586 10:10:52 INFO - 2015-11-11 10:10:52,953 DEBUG : BROWSER_OUTPUT: |1;ext.html;566.9546436285096;574.8649067469144;584.1763114009245;589.4370875813596;593.3236110833648;39468;40340;40358.192836143295;40458;40495.79752101239;43188.784056079756;43470.56529434705;43748.78125609367;43772.12455750883;43791.56208437915;8779.517126558037;8899.33255005874;8900.554972251362;8906.599203035847;8919.108089191093;8675.08911564286;8704.129587041278;8792.648294068229;8797;8804.86792698107;8684.348673849456;8749.081346458626;8788.912110878873;8794.252488538483;8814.647414103429;8765.123487651248;8804.823903521925;8829.337799664987;8837.690680826205;8846.071162527971;8647.264982476434;8702.869456958151;8740;8778.692745753868;8782.38523303369;40179.39730904039;40292.79853600713;40309.19381612381;40357.789266322055;40440.39339409911;3288.145082278601;3586.7130629549574;3618.7285953553323;3700.2229531798353;3941.625545573166;29932.401351973058;30229;30325.24186895323;30446.84776576103;30829;3193.4411477991257;3248.626407963091;3274.8526316315824;3304.983475082633;3356.87544672535;266489;269095.999999998;269120;269788;270226;56816.71591642015;57705.71147144322;58345;58649.41350586525;58742.41257587455;68263;68333.31666683369;68408.3159168412;68928.6553567229;69273.65363173152;13977.72044559103;14292.285385730673;14308.141511509342;14323.713525729427;14336.569902902722;10456;10462.947685261524;10491.947540262403;10534.209934254808;10558.419286939292;19710.507237318896;20037.398878033684;20038.198472060954;20059;20069.39791806219;7491.737789177353;7505.211952744992;7599.354054905284;7629.427792915553;7727.690892364242;868.6221493650156;917.7063339731355;929.7907970706536;934.9953250233706;965.6185806606351;28223.858880705466;28277.15168544947;28482.857585712354;28778.424431511252;28998;989.6684610655367;990.0643891522586;1098.961536346224;1121.1423261205184;1126.985712858434;13926.860731392557;15368.231588420535;15730.606734831721;16095.275712592962;16495.34018639241;324612;324622;328825;328965;329860;52414.213786793225;53218.201726974126;53243;53285;53423;1313.8883194928537;1362.1010133312166;1377.455904917552;1378.0973462382156;1380.0339762166523;28174.43651127007;29273.7072629271;29276.121716348545;29319.267018324714;29548.261293467836;46364.76817616025;46642;46662.76668616635;46785;46935.06129877452;308849;312827;314114;314604;315458;31362.372752544365;32569;32874;32968;33197.83401082979;41847.37228941507;42819.357709633754;43226;43731.34402984021;44344.11311773811;36255.81872090622;36464;36690.44964325591;36919.26161476809;37440.251194976496;36262.4560631596;36681.165941703344;36825.26349473049;36858;37081.62918370782;35612.28775424425;35712.28575428425;35715;35795.82102089473;36007.45988810118;30302.84848575743;32995.175120622174;32999.50500742539;33146.83426582852;33201.50197747084;25018.62472062957;25274.87362563249;25340.11309604155;25613.61579576345;25664.101756438435 10:10:52 INFO - 2015-11-11 10:10:52,954 DEBUG : BROWSER_OUTPUT: |2;jquery.html;344.2787360479796;344.4127762165508;350.73869966874685;355.0679466400698;357.41919381005874;11210.775784484305;11561.884381156186;16846.32614695412;17077.743833842487;17839.197236124357;18132.18405171767;18183.09084545774;18447.907760461214;18585.628287434243;18645.16096775645;5897.646141231529;6082.300535438415;6082.300535438437;6087.4825639820665;6106.664133472657;6029.427204415573;6044.093385992092;6058.485028772538;6284.308726040132;6477.54657173998;6394.744210231585;6413.967930160343;6445.645489498076;6455.128557644728;6642.966785166067;6454.483641308731;6577.144971153743;6606.405423511883;6630.933690663104;6855.4172895303955;6577.506686998494;6581.2760596334365;6582.17722784652;6593.3736295051895;6598.769043083469;20792.16831326745;21178.470538236666;21633.56732865334;21797.237096701538;21930.342089737333;2103.6108319960704;2120.713703650003;2218.633925402307;2220.134147682405;2380.3811009137576;14282.785758213635;14448.638784030378;14552.417903283962;14567.125972441687;14763.188024658639;1850.518865095085;1858.5353661584604;1877.220953304377;1949.4444083436294;1997.5805080933021;68287;70047.2995270046;70068.79587224731;70595.64702176508;72071;16188.109653969144;16331.673366532603;16349;16464.588385290223;16477.423290185026;23785.881070594536;23928.641070383957;24367;24386;24450.655213963048;8718.215360617574;8862.822743545223;8887.73336799897;8925.062868398854;8952.060033696369;7026.367626913602;7035.155781306276;7060.7881763547175;7125.501214914906;7428.4428667850125;7995.840083198304;8075.838483230303;8136.959315203386;8206.93309869713;8210.753677389688;1239.9194052386747;3200;3298.686624770643;3302.6862448067395;3305.4380755271663;471.6062088156359;483.1255427675918;493.33646245799343;513.8175947538645;530.0432718942346;11049.508316377347;11236.157288203418;11730.472128754227;11939.52241910314;12056.75886482283;490.0786521339858;495.7744226377062;497.5546885537424;501.07551567358166;522.2036394498421;6666.333366663392;6758.357955994173;6844.4182244509775;6856.485763567753;6950.443964482829;518585;522895;531643;533711;535058.6494135009;80890.59554702189;81709;82119.17880821235;82687.58656206801;82712.58643706863;522.339240860312;525.2331595870072;526.6445149524056;528.1206790693452;544.1810075835921;10935.773946685587;11148.219624626197;11175.944120279346;11218.719532011764;11283.605073822377;33634;36069.63930360663;36948.261034779694;37305.81347093247;37486.2502749938;42334.153316934106;43904.56095439005;44518.55481445144;48764.51235487741;49258.26112608385;6932.61870597122;6954.3393377629045;6979.40675042627;7014.579125252501;7063.646817658993;12662.366881656064;12812.61562153137;13051.543195988095;13074.542391016268;13075.607731768063;10363.585456581652;10373.948130259301;11076.224664273746;11391.601293954673;11434.313941163557;10700.785984280426;11009.779804403706;11189.104871610414;11267.605633802777;11278.887211127783;11199.21605487608;11313.71715707081;11390.088792896382;11560;11576.131790115944;6930.237673855771;7001.964990175016;7006.649667516502;7018.649067546704;7026.859462810818;11138.10895128404;11200.495977680861;11201.775964480501;11252.156088293574;11290.830637540608 10:10:52 INFO - 2015-11-11 10:10:52,955 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1516.2039929037262;1725.284007137038;1737.18352374384;1778.3064604804122;1799.1543974332064;7281.563106213631;7541.396688264933;7608.239176082389;7623.771286861389;7926.762197134095;7564.886526702104;7601;7631.313181813635;7675.078990521145;7682.5006374585755;2207.073029327686;2239.7536271010176;2241.3948233976816;2244.06871148474;2244.2706120510816;2301.2981040782556;2303.79265866072;2343.343863718153;2344.589696803061;2351.247600767755;2198.8565945708224;2216.501287210373;2229.665550167472;2261.366817291153;2270.965935510969;2261.9208327708616;2275.8975846086964;2317.24689475921;2326.1858349577683;2336.4158960259933;2278.920237791686;2305.6772051912744;2324.4537533679572;2328.161861729776;2335.6730057791924;7596.506227095221;7680.654370553339;7722.652480638385;7742.806429839243;7778.64996075178;4590.3344015117955;4650.883727906796;4670.9065818683775;4689.88275293117;4709.788059537329;2960.407918416325;2974.092901664991;3016.9849150754326;3039.6352437707396;3059.35753491767;944.390867890207;948.0850978805416;983.4689267795382;984.3945973226486;988.6391467114523;10423.322484038514;10466.11038061758;10498.37009779408;10504.2647014709;10559.947200264027;4096.959030409717;4152.1695660867945;4175.436316097288;4176.624103830609;4192.580741925783;8484.618192181366;8537.615807288686;8563.914360856312;8564.057953625097;8573.22840944318;4574.931376029363;4627.444706635225;4634.397528321297;4638.443386793607;4641;4210.705250632426;4286.5284818669925;4299.290617048152;4310.762908040025;4326;3312.585926759155;3362.2434952136064;3366.5118557808983;3367.1413789483527;3388.034410193083;1057.0592172966067;1094.6661268313082;1098.077614803553;1110.5113749949996;1115.0800589513683;1020.974475638115;1025.5487585462372;1072.0030371754344;1191.1959427386653;1349.9942542805672;7116.217216106224;7193.992841002264;7197.568145911262;7215.855682886313;7224.988501609779;1077.342820879263;1082.2694681090234;1085.842552829851;1087.907527860125;1118.5693507999315;5651.8304450866535;5709.65742055478;5722.399148089391;5722.484976352148;5752.597318187687;9126;9134.269258459308;9164.816703665889;9174.036726143791;9349.859752103725;9212.447253164832;9223.400478968846;9261.212796912203;9266.397684150508;9280.7679808004;7080.398166155832;7111.324424179695;7183.92816071843;7193.064901562868;7221.855562888818;6812.591244525344;6856.41720453767;6876.518643694893;6879.071325371011;6881.552699074544;7864.84270314602;8091.676332946617;8203.58982050907;8269.917300826915;8301.709440169565;8165.14266002085;8270.37972152103;8315;8321.12628174033;8366;6638.900416493853;6669.699863506251;6757;6797.592144471348;6839.487038472035;7623.390128789572;7633.465657403928;7637.274458926393;7670.923290767021;7694.499857509244;6970.302969702989;7033.788986330418;7123.145222573325;7204.171520275026;7252.41980641558;6829.829254268683;6995.405390541861;7018.33325834045;7070.1869285030825;7141.714331426685;7000.054992576141;7066.081409416743;7099;7103.786886393416;7118.893216601651;6279.654618995999;6320.936790632035;6349.841253968688;6358.650274234961;6374.617522948638;6366.236051673829;6420.101185834081;6437.452816510649;6447.484201263981;6465.094886715958 10:10:52 INFO - 2015-11-11 10:10:52,956 DEBUG : BROWSER_OUTPUT: |4;prototype.html;320.95185722141673;326.79085385353363;329.90267870978073;331.4597206553318;340.984655690494;6047.6976151192375;6072.180255665484;6077.209962704847;6084.361142080079;6157.661328626935;5960.970195149018;5985.940140598593;5991.101334799782;5995.550333724967;5996.070609055603;4548.2495388260895;4557.544245575449;4560.589546940775;4570.748608826513;4571.588557029867;4557.156925968689;4559.430071241095;4561.042181141947;4567.566081222279;4571.977140114294;4443.044745379742;4508.2561377372695;4546.499885012646;4587.564181402778;4607.677462577621;4572.885677858047;4579.107074120548;4584.312353147021;4595.586397224232;4611.19304121779;3965.7025723070597;3976.960230397688;3980.383040628707;3986.40203969404;3996.040950171967;5708.71456427177;5728.026235539926;5731.455511726379;5736.024875771129;5743.368229494752;5147.716875571842;5226.52961233487;5247.344081989751;5294.761735721863;5329.227262046981;6273.937260627426;6276.843078923018;6279.058141278799;6283.277423096357;6288.151099601587;4300.247456695097;4314.9784251078545;4321.24378233811;4330.090680957002;4344.500382456026;6379.36206379363;6477.417032467053;6486.837829054264;6522.249941256721;6522.869542609169;4503.347014682919;4504.887377815581;4509.7970591323465;4518.81924723014;4528.117017181684;4566.109608626286;4575.107853968444;4576.679632425765;4580.770961451914;4582.702124361906;5300.787968481218;5302.443243459381;5305.814296499604;5308.840734777963;5315.123004704181;6275.058741188858;6354.078658594478;6398.680065996681;6403.775867844603;6427.2929977702415;1610.4443966831425;1629.055148014149;1629.0958518022612;1630.1115891838976;1661.7008938390964;1094.6661268313242;1100.6697990602947;1103.674416047268;1109.2346281066039;1118.0664145438486;6086.756529738761;6091.9695401523595;6092.268927728613;6097.8475538111015;6106.236720409949;6405.6797160141805;6419.229692436844;6429.58207716497;6473.870522589522;6474.061261117112;6035.245594300713;6152.261728592597;6195.16365290689;6201.348858369896;6206.565540412128;3645.325614761278;3646.1431563582537;3671.908202294964;3672.137047793766;3672.467492213614;6811.693473793691;6827.044213810071;6828.556143850634;6837.521373503906;6853.074834897225;6589.077529145828;6740.325967403319;6742.123523941857;6748.696308666122;6754.18949726036;6788.083608712859;6858.211305699909;6862.656867156622;6863.691133898987;6869.381755642016;6543.476521878333;6555.344465553407;6560.737570497317;6563.474922006323;6571.901421478778;6374.968125159345;6505.2844187138435;6508.902366464602;6510.609363438209;6512.73949042033;6800.625965571941;6802.115724955724;6802.455803535607;6824.93175068243;6832.863342733217;4502.57225563571;4506.616937560213;4508.549145085465;4511.233090374579;4535.478419981744;6470.094186813756;6498.967505162444;6508.544401892012;6525.086487891604;6562.245341785565;6382.521310901608;6386.616802991835;6412.647304398303;6413.230412350548;6415.069814876723;6325.367463253638;6327.715252813542;6329.778457753957;6367.554271200971;6369.235691717024;6133.9079913802225;6187.3503282154725;6204.689765511616;6255.71849266775;6267.717952692231;6448.903266450913;6455.741770329322;6487.22153341602;6524.217093948757;6534.019897015486;6354.6822658867795;6359.046143078575;6359.8092057238355;6369.426751592379;6391.105245265573 10:10:52 INFO - 2015-11-11 10:10:52,958 DEBUG : BROWSER_OUTPUT: |5;yui.html;729.9854002919942;768.4198430185211;816.5631387207845;817.4563914996528;835.6991483066091;13246.07277490576;13507.79738303925;13514.526991555298;13535.18788872666;13621.931890340558;11356.602518911839;12087.395630218498;12280.385980700974;12511.624651260454;13176.341182940838;821.1501096365248;833.6207025803275;835.4736515994945;836.0135040652028;836.2557323981662;813.6948644258404;824.1758241758242;829.0217543298905;830.0578843013193;830.4104086098877;866.6879923227633;868.1231955724701;870.447265986097;872.7948932001007;875.120503893586;867.9869801952975;869.5391442535466;869.6825658634616;870.190722627959;873.5370253765515;630.1083966187839;633.6768248193408;634.3941535833268;634.6287421858218;635.5487603801307;12560.623181304576;12609.369531523478;12617.810732839014;12621.116521843474;12644.747105057939;10640.361578305248;10701.678949631445;10803.78392432147;10811.675649730521;10845;10266.538005789758;10278.22913281507;10305.227107966932;10480.161587073017;10526.894731052667;3292;3346.966530334714;3353.6143343515564;3362.159460134966;3365.9831700841582;45130.32304515435;45959.540404595864;46220.075598488176;46336.304955425694;46360.53639463596;7725.613719314012;7732.381409487228;7757.301842834172;7779.844403111906;7887.171846956102;12609.684757881127;12701;12735.490580376867;12776.61670149897;12802.743945121045;6725.697343619451;6778;6806.319368063154;7068.11648543932;7074.469414793808;4416.249237629547;4460.241758900995;4516.390287311171;4535.7732113394195;4603.125406172817;2787.108125399893;2794.2734888929026;2795.1335086123368;2818.1968139080263;2829.915102546927;446.8525386622407;448.68591985610203;453.2792859353578;488.1043285570946;500.3445486412811;537.3471232452589;605.9244840408222;628.2335550628226;679.2188982669969;717.8923161525709;8322.753140450188;8772.166644168794;8864.822703546022;8888.866667;8891.612607495552;540.3866611396094;565.4229016114546;576.4523702482659;629.8899679590708;680.323078536859;4031.677465802729;4042.939355909664;4190.099128687286;4198.718747663134;4380.8685739427865;59743;60356.39643603508;60592;60643;60741.39258607446;51415.48584514107;51665.741671291406;51832;51960;52081.21878171831;46690;47156;47404.288935665994;47539;48534;8713.411163152865;8888.60001299956;8970.461772293422;9013.639454422011;9020.323475739215;35563.288734224654;36078.27843443064;36174;36238.09404764902;36865.815670921475;44745;46486;46897.76551117223;47215.29177062278;47317.76341118272;8546.914530854612;8621.69824056155;8659.87010194835;8949.32880034013;9068.90931090707;11918.510510031709;12045.51817927273;12224.144309898222;12452.564160254347;12836.486540538273;11313.20807543464;11460.94269528647;11478.483468243781;11867.584634538096;11879.10906681985;10745.623903163665;10870.891291087304;10915.508802103766;11047.116230701686;11428.82602798025;10988.615398461016;11197.72005699864;11341.489632966372;11702.824457633313;11742.236754610924;9462.148406643435;9638;9776.951115244377;9788.510574471391;9967.252456065678;9175.66510367089;9290.210332121846;9637.18083962843;9748.268879833899;9760.609575616896 10:10:52 INFO - 2015-11-11 10:10:52,958 DEBUG : BROWSER_OUTPUT: __end_tp_report 10:10:52 INFO - 2015-11-11 10:10:52,958 DEBUG : BROWSER_OUTPUT: __start_cc_report 10:10:52 INFO - 2015-11-11 10:10:52,958 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,288 10:10:52 INFO - 2015-11-11 10:10:52,958 DEBUG : BROWSER_OUTPUT: __end_cc_report 10:10:52 INFO - 2015-11-11 10:10:52,959 DEBUG : BROWSER_OUTPUT: __startTimestamp1447265452946__endTimestamp 10:10:52 INFO - 2015-11-11 10:10:52,959 DEBUG : BROWSER_OUTPUT: 10:10:52 INFO - 2015-11-11 10:10:52,959 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 10:10:52 INFO - 2015-11-11 10:10:52,960 DEBUG : BROWSER_OUTPUT: Number of tests: 6 10:10:52 INFO - 2015-11-11 10:10:52,960 DEBUG : BROWSER_OUTPUT: 10:10:52 INFO - 2015-11-11 10:10:52,960 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:5517.25 Median:5748.45 stddev:619.48 (10.8%) stddev-sans-first:594.76 10:10:52 INFO - 2015-11-11 10:10:52,960 DEBUG : BROWSER_OUTPUT: Values: 3227.0 3335.4 3359.6 3376.4 3381.8 5370.1 5522.1 5534.2 5541.6 5559.9 5442.0 5483.1 5517.5 5542.0 5559.8 5007.3 5079.1 5132.4 5157.8 5158.6 5080.3 5158.8 5167.5 5172.2 5197.1 4924.4 4951.3 4951.7 5033.5 5045.9 5032.0 5039.7 5050.1 5075.0 5096.6 5016.7 5042.9 5046.4 5047.1 5068.3 5012.2 5141.8 5144.5 5214.7 5215.3 5930.1 5974.3 5978.5 5988.9 5995.2 5798.7 5995.9 6005.2 6006.0 6015.1 5465.4 5523.9 5529.9 5529.9 5548.9 6082.8 6089.1 6101.0 6118.1 6139.6 5855.4 5895.9 5911.1 5920.8 5940.9 5671.7 5824.2 5872.5 5972.8 6006.6 5931.2 6011.1 6017.9 6020.2 6028.3 5986.9 5992.5 5994.1 6009.6 6023.4 4393.5 4472.4 4475.9 4520.7 4577.2 4050.7 4059.1 4078.7 4128.9 4140.9 5391.1 5751.0 5760.1 5774.6 5775.4 5830.6 5884.7 5945.9 5971.5 6003.8 5610.7 5639.1 5644.0 5660.6 5686.6 4995.5 5098.8 5169.0 5188.1 5189.2 6046.2 6116.1 6132.6 6134.8 6140.6 6010.4 6015.2 6016.5 6021.1 6069.2 5845.2 5969.5 5995.3 6239.5 6263.0 5889.3 5890.1 5898.9 5905.1 5929.8 5932.6 5934.6 5937.5 5941.7 5945.7 5625.1 5741.7 5748.5 5814.1 5882.7 5666.5 5873.7 5885.6 5887.6 5903.1 5744.1 5774.2 5790.1 5790.5 5791.5 5626.7 5752.5 5761.5 5851.9 5880.7 5677.9 5700.3 5720.9 5723.9 5725.1 10:10:52 INFO - 2015-11-11 10:10:52,960 DEBUG : BROWSER_OUTPUT: 10:10:52 INFO - 2015-11-11 10:10:52,960 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:47603.59 Median:36757.86 stddev:79605.51 (216.6%) stddev-sans-first:79750.49 10:10:52 INFO - 2015-11-11 10:10:52,961 DEBUG : BROWSER_OUTPUT: Values: 567.0 574.9 584.2 589.4 593.3 39468.0 40340.0 40358.2 40458.0 40495.8 43188.8 43470.6 43748.8 43772.1 43791.6 8779.5 8899.3 8900.6 8906.6 8919.1 8675.1 8704.1 8792.6 8797.0 8804.9 8684.3 8749.1 8788.9 8794.3 8814.6 8765.1 8804.8 8829.3 8837.7 8846.1 8647.3 8702.9 8740.0 8778.7 8782.4 40179.4 40292.8 40309.2 40357.8 40440.4 3288.1 3586.7 3618.7 3700.2 3941.6 29932.4 30229.0 30325.2 30446.8 30829.0 3193.4 3248.6 3274.9 3305.0 3356.9 266489.0 269096.0 269120.0 269788.0 270226.0 56816.7 57705.7 58345.0 58649.4 58742.4 68263.0 68333.3 68408.3 68928.7 69273.7 13977.7 14292.3 14308.1 14323.7 14336.6 10456.0 10462.9 10491.9 10534.2 10558.4 19710.5 20037.4 20038.2 20059.0 20069.4 7491.7 7505.2 7599.4 7629.4 7727.7 868.6 917.7 929.8 935.0 965.6 28223.9 28277.2 28482.9 28778.4 28998.0 989.7 990.1 1099.0 1121.1 1127.0 13926.9 15368.2 15730.6 16095.3 16495.3 324612.0 324622.0 328825.0 328965.0 329860.0 52414.2 53218.2 53243.0 53285.0 53423.0 1313.9 1362.1 1377.5 1378.1 1380.0 28174.4 29273.7 29276.1 29319.3 29548.3 46364.8 46642.0 46662.8 46785.0 46935.1 308849.0 312827.0 314114.0 314604.0 315458.0 31362.4 32569.0 32874.0 32968.0 33197.8 41847.4 42819.4 43226.0 43731.3 44344.1 36255.8 36464.0 36690.4 36919.3 37440.3 36262.5 36681.2 36825.3 36858.0 37081.6 35612.3 35712.3 35715.0 35795.8 36007.5 30302.8 32995.2 32999.5 33146.8 33201.5 25018.6 25274.9 25340.1 25613.6 25664.1 10:10:52 INFO - 2015-11-11 10:10:52,961 DEBUG : BROWSER_OUTPUT: 10:10:52 INFO - 2015-11-11 10:10:52,961 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:28848.36 Median:43119.36 stddev:86510.03 (200.6%) stddev-sans-first:86726.23 10:10:52 INFO - 2015-11-11 10:10:52,962 DEBUG : BROWSER_OUTPUT: Values: 344.3 344.4 350.7 355.1 357.4 11210.8 11561.9 16846.3 17077.7 17839.2 18132.2 18183.1 18447.9 18585.6 18645.2 5897.6 6082.3 6082.3 6087.5 6106.7 6029.4 6044.1 6058.5 6284.3 6477.5 6394.7 6414.0 6445.6 6455.1 6643.0 6454.5 6577.1 6606.4 6630.9 6855.4 6577.5 6581.3 6582.2 6593.4 6598.8 20792.2 21178.5 21633.6 21797.2 21930.3 2103.6 2120.7 2218.6 2220.1 2380.4 14282.8 14448.6 14552.4 14567.1 14763.2 1850.5 1858.5 1877.2 1949.4 1997.6 68287.0 70047.3 70068.8 70595.6 72071.0 16188.1 16331.7 16349.0 16464.6 16477.4 23785.9 23928.6 24367.0 24386.0 24450.7 8718.2 8862.8 8887.7 8925.1 8952.1 7026.4 7035.2 7060.8 7125.5 7428.4 7995.8 8075.8 8137.0 8206.9 8210.8 1239.9 3200.0 3298.7 3302.7 3305.4 471.6 483.1 493.3 513.8 530.0 11049.5 11236.2 11730.5 11939.5 12056.8 490.1 495.8 497.6 501.1 522.2 6666.3 6758.4 6844.4 6856.5 6950.4 518585.0 522895.0 531643.0 533711.0 535058.6 80890.6 81709.0 82119.2 82687.6 82712.6 522.3 525.2 526.6 528.1 544.2 10935.8 11148.2 11175.9 11218.7 11283.6 33634.0 36069.6 36948.3 37305.8 37486.3 42334.2 43904.6 44518.6 48764.5 49258.3 6932.6 6954.3 6979.4 7014.6 7063.6 12662.4 12812.6 13051.5 13074.5 13075.6 10363.6 10373.9 11076.2 11391.6 11434.3 10700.8 11009.8 11189.1 11267.6 11278.9 11199.2 11313.7 11390.1 11560.0 11576.1 6930.2 7002.0 7006.6 7018.6 7026.9 11138.1 11200.5 11201.8 11252.2 11290.8 10:10:52 INFO - 2015-11-11 10:10:52,962 DEBUG : BROWSER_OUTPUT: 10:10:52 INFO - 2015-11-11 10:10:52,962 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5378.85 Median:6397.36 stddev:2760.09 (43.1%) stddev-sans-first:2752.57 10:10:52 INFO - 2015-11-11 10:10:52,962 DEBUG : BROWSER_OUTPUT: Values: 1516.2 1725.3 1737.2 1778.3 1799.2 7281.6 7541.4 7608.2 7623.8 7926.8 7564.9 7601.0 7631.3 7675.1 7682.5 2207.1 2239.8 2241.4 2244.1 2244.3 2301.3 2303.8 2343.3 2344.6 2351.2 2198.9 2216.5 2229.7 2261.4 2271.0 2261.9 2275.9 2317.2 2326.2 2336.4 2278.9 2305.7 2324.5 2328.2 2335.7 7596.5 7680.7 7722.7 7742.8 7778.6 4590.3 4650.9 4670.9 4689.9 4709.8 2960.4 2974.1 3017.0 3039.6 3059.4 944.4 948.1 983.5 984.4 988.6 10423.3 10466.1 10498.4 10504.3 10559.9 4097.0 4152.2 4175.4 4176.6 4192.6 8484.6 8537.6 8563.9 8564.1 8573.2 4574.9 4627.4 4634.4 4638.4 4641.0 4210.7 4286.5 4299.3 4310.8 4326.0 3312.6 3362.2 3366.5 3367.1 3388.0 1057.1 1094.7 1098.1 1110.5 1115.1 1021.0 1025.5 1072.0 1191.2 1350.0 7116.2 7194.0 7197.6 7215.9 7225.0 1077.3 1082.3 1085.8 1087.9 1118.6 5651.8 5709.7 5722.4 5722.5 5752.6 9126.0 9134.3 9164.8 9174.0 9349.9 9212.4 9223.4 9261.2 9266.4 9280.8 7080.4 7111.3 7183.9 7193.1 7221.9 6812.6 6856.4 6876.5 6879.1 6881.6 7864.8 8091.7 8203.6 8269.9 8301.7 8165.1 8270.4 8315.0 8321.1 8366.0 6638.9 6669.7 6757.0 6797.6 6839.5 7623.4 7633.5 7637.3 7670.9 7694.5 6970.3 7033.8 7123.1 7204.2 7252.4 6829.8 6995.4 7018.3 7070.2 7141.7 7000.1 7066.1 7099.0 7103.8 7118.9 6279.7 6320.9 6349.8 6358.7 6374.6 6366.2 6420.1 6437.5 6447.5 6465.1 10:10:52 INFO - 2015-11-11 10:10:52,962 DEBUG : BROWSER_OUTPUT: 10:10:52 INFO - 2015-11-11 10:10:52,962 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:5323.44 Median:6089.36 stddev:1600.45 (26.3%) stddev-sans-first:1560.27 10:10:52 INFO - 2015-11-11 10:10:52,963 DEBUG : BROWSER_OUTPUT: Values: 321.0 326.8 329.9 331.5 341.0 6047.7 6072.2 6077.2 6084.4 6157.7 5961.0 5985.9 5991.1 5995.6 5996.1 4548.2 4557.5 4560.6 4570.7 4571.6 4557.2 4559.4 4561.0 4567.6 4572.0 4443.0 4508.3 4546.5 4587.6 4607.7 4572.9 4579.1 4584.3 4595.6 4611.2 3965.7 3977.0 3980.4 3986.4 3996.0 5708.7 5728.0 5731.5 5736.0 5743.4 5147.7 5226.5 5247.3 5294.8 5329.2 6273.9 6276.8 6279.1 6283.3 6288.2 4300.2 4315.0 4321.2 4330.1 4344.5 6379.4 6477.4 6486.8 6522.2 6522.9 4503.3 4504.9 4509.8 4518.8 4528.1 4566.1 4575.1 4576.7 4580.8 4582.7 5300.8 5302.4 5305.8 5308.8 5315.1 6275.1 6354.1 6398.7 6403.8 6427.3 1610.4 1629.1 1629.1 1630.1 1661.7 1094.7 1100.7 1103.7 1109.2 1118.1 6086.8 6092.0 6092.3 6097.8 6106.2 6405.7 6419.2 6429.6 6473.9 6474.1 6035.2 6152.3 6195.2 6201.3 6206.6 3645.3 3646.1 3671.9 3672.1 3672.5 6811.7 6827.0 6828.6 6837.5 6853.1 6589.1 6740.3 6742.1 6748.7 6754.2 6788.1 6858.2 6862.7 6863.7 6869.4 6543.5 6555.3 6560.7 6563.5 6571.9 6375.0 6505.3 6508.9 6510.6 6512.7 6800.6 6802.1 6802.5 6824.9 6832.9 4502.6 4506.6 4508.5 4511.2 4535.5 6470.1 6499.0 6508.5 6525.1 6562.2 6382.5 6386.6 6412.6 6413.2 6415.1 6325.4 6327.7 6329.8 6367.6 6369.2 6133.9 6187.4 6204.7 6255.7 6267.7 6448.9 6455.7 6487.2 6524.2 6534.0 6354.7 6359.0 6359.8 6369.4 6391.1 10:10:52 INFO - 2015-11-11 10:10:52,963 DEBUG : BROWSER_OUTPUT: 10:10:52 INFO - 2015-11-11 10:10:52,963 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:13572.77 Median:47471.64 stddev:16331.23 (34.4%) stddev-sans-first:16348.57 10:10:52 INFO - 2015-11-11 10:10:52,964 DEBUG : BROWSER_OUTPUT: Values: 730.0 768.4 816.6 817.5 835.7 13246.1 13507.8 13514.5 13535.2 13621.9 11356.6 12087.4 12280.4 12511.6 13176.3 821.2 833.6 835.5 836.0 836.3 813.7 824.2 829.0 830.1 830.4 866.7 868.1 870.4 872.8 875.1 868.0 869.5 869.7 870.2 873.5 630.1 633.7 634.4 634.6 635.5 12560.6 12609.4 12617.8 12621.1 12644.7 10640.4 10701.7 10803.8 10811.7 10845.0 10266.5 10278.2 10305.2 10480.2 10526.9 3292.0 3347.0 3353.6 3362.2 3366.0 45130.3 45959.5 46220.1 46336.3 46360.5 7725.6 7732.4 7757.3 7779.8 7887.2 12609.7 12701.0 12735.5 12776.6 12802.7 6725.7 6778.0 6806.3 7068.1 7074.5 4416.2 4460.2 4516.4 4535.8 4603.1 2787.1 2794.3 2795.1 2818.2 2829.9 446.9 448.7 453.3 488.1 500.3 537.3 605.9 628.2 679.2 717.9 8322.8 8772.2 8864.8 8888.9 8891.6 540.4 565.4 576.5 629.9 680.3 4031.7 4042.9 4190.1 4198.7 4380.9 59743.0 60356.4 60592.0 60643.0 60741.4 51415.5 51665.7 51832.0 51960.0 52081.2 46690.0 47156.0 47404.3 47539.0 48534.0 8713.4 8888.6 8970.5 9013.6 9020.3 35563.3 36078.3 36174.0 36238.1 36865.8 44745.0 46486.0 46897.8 47215.3 47317.8 8546.9 8621.7 8659.9 8949.3 9068.9 11918.5 12045.5 12224.1 12452.6 12836.5 11313.2 11460.9 11478.5 11867.6 11879.1 10745.6 10870.9 10915.5 11047.1 11428.8 10988.6 11197.7 11341.5 11702.8 11742.2 9462.1 9638.0 9777.0 9788.5 9967.3 9175.7 9290.2 9637.2 9748.3 9760.6 10:10:52 INFO - 2015-11-11 10:10:52,964 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 10:10:52 INFO - 2015-11-11 10:10:52,964 DEBUG : BROWSER_OUTPUT: 10:10:53 INFO - 2015-11-11 10:10:53,625 INFO : Browser exited with error code: 0 10:10:53 INFO - 2015-11-11 10:10:53,644 INFO : Completed test dromaeo_css (00:18:31) 10:10:53 INFO - 2015-11-11 10:10:53,644 INFO : Starting test kraken 10:10:53 INFO - 2015-11-11 10:10:53,644 DEBUG : operating with platform_type : linux_ 10:10:53 INFO - 2015-11-11 10:10:53,644 INFO : Initialising browser for kraken test... 10:10:53 INFO - 2015-11-11 10:10:53,651 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpzBha0s/profile http://localhost:34455/getInfo.html 10:10:57 INFO - 2015-11-11 10:10:57,775 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 10:10:57 INFO - 2015-11-11 10:10:57,775 DEBUG : BROWSER_OUTPUT: colorDepth:24 10:10:57 INFO - 2015-11-11 10:10:57,775 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 10:10:57 INFO - 2015-11-11 10:10:57,775 DEBUG : BROWSER_OUTPUT: __metrics 10:10:58 INFO - 2015-11-11 10:10:58,777 INFO : Browser initialized. 10:10:58 INFO - 2015-11-11 10:10:58,778 INFO : Running cycle 1/1 for kraken test... 10:10:58 INFO - 2015-11-11 10:10:58,778 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpzBha0s/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 10:11:10 INFO - 2015-11-11 10:11:10,567 DEBUG : BROWSER_OUTPUT: RSS: Main: 139272192 10:11:10 INFO - 2015-11-11 10:11:10,567 DEBUG : BROWSER_OUTPUT: 10:11:13 INFO - 2015-11-11 10:11:13,041 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:34455/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:34455/tests/kraken/driver.html?testName=audio-beat-detection) 10:11:13 INFO - 2015-11-11 10:11:13,647 DEBUG : BROWSER_OUTPUT: RSS: Main: 141660160 10:11:13 INFO - 2015-11-11 10:11:13,647 DEBUG : BROWSER_OUTPUT: 10:11:16 INFO - 2015-11-11 10:11:16,295 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:34455/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:34455/tests/kraken/driver.html?testName=audio-dft) 10:11:16 INFO - 2015-11-11 10:11:16,896 DEBUG : BROWSER_OUTPUT: RSS: Main: 141496320 10:11:16 INFO - 2015-11-11 10:11:16,897 DEBUG : BROWSER_OUTPUT: 10:11:19 INFO - 2015-11-11 10:11:19,742 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:34455/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:34455/tests/kraken/driver.html?testName=audio-fft) 10:11:20 INFO - 2015-11-11 10:11:20,323 DEBUG : BROWSER_OUTPUT: RSS: Main: 137392128 10:11:20 INFO - 2015-11-11 10:11:20,324 DEBUG : BROWSER_OUTPUT: 10:11:22 INFO - 2015-11-11 10:11:22,295 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:34455/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:34455/tests/kraken/driver.html?testName=audio-oscillator) 10:11:22 INFO - 2015-11-11 10:11:22,876 DEBUG : BROWSER_OUTPUT: RSS: Main: 137662464 10:11:22 INFO - 2015-11-11 10:11:22,876 DEBUG : BROWSER_OUTPUT: 10:11:25 INFO - 2015-11-11 10:11:25,091 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:34455/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:34455/tests/kraken/driver.html?testName=imaging-gaussian-blur) 10:11:25 INFO - 2015-11-11 10:11:25,660 DEBUG : BROWSER_OUTPUT: RSS: Main: 138121216 10:11:25 INFO - 2015-11-11 10:11:25,660 DEBUG : BROWSER_OUTPUT: 10:11:28 INFO - 2015-11-11 10:11:28,665 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:34455/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:34455/tests/kraken/driver.html?testName=imaging-darkroom) 10:11:29 INFO - 2015-11-11 10:11:29,252 DEBUG : BROWSER_OUTPUT: RSS: Main: 137551872 10:11:29 INFO - 2015-11-11 10:11:29,252 DEBUG : BROWSER_OUTPUT: 10:11:32 INFO - 2015-11-11 10:11:32,673 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:34455/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:34455/tests/kraken/driver.html?testName=imaging-desaturate) 10:11:33 INFO - 2015-11-11 10:11:33,259 DEBUG : BROWSER_OUTPUT: RSS: Main: 139112448 10:11:33 INFO - 2015-11-11 10:11:33,259 DEBUG : BROWSER_OUTPUT: 10:11:36 INFO - 2015-11-11 10:11:36,068 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:34455/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:34455/tests/kraken/driver.html?testName=json-parse-financial) 10:11:36 INFO - 2015-11-11 10:11:36,655 DEBUG : BROWSER_OUTPUT: RSS: Main: 138891264 10:11:36 INFO - 2015-11-11 10:11:36,655 DEBUG : BROWSER_OUTPUT: 10:11:38 INFO - 2015-11-11 10:11:38,252 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:34455/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:34455/tests/kraken/driver.html?testName=json-stringify-tinderbox) 10:11:38 INFO - 2015-11-11 10:11:38,838 DEBUG : BROWSER_OUTPUT: RSS: Main: 138465280 10:11:38 INFO - 2015-11-11 10:11:38,838 DEBUG : BROWSER_OUTPUT: 10:11:40 INFO - 2015-11-11 10:11:40,661 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:34455/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:34455/tests/kraken/driver.html?testName=stanford-crypto-aes) 10:11:41 INFO - 2015-11-11 10:11:41,267 DEBUG : BROWSER_OUTPUT: RSS: Main: 139747328 10:11:41 INFO - 2015-11-11 10:11:41,267 DEBUG : BROWSER_OUTPUT: 10:11:43 INFO - 2015-11-11 10:11:43,365 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:34455/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:34455/tests/kraken/driver.html?testName=stanford-crypto-ccm) 10:11:43 INFO - 2015-11-11 10:11:43,952 DEBUG : BROWSER_OUTPUT: RSS: Main: 139497472 10:11:43 INFO - 2015-11-11 10:11:43,952 DEBUG : BROWSER_OUTPUT: 10:11:46 INFO - 2015-11-11 10:11:46,399 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:34455/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:34455/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 10:11:46 INFO - 2015-11-11 10:11:46,992 DEBUG : BROWSER_OUTPUT: RSS: Main: 139677696 10:11:46 INFO - 2015-11-11 10:11:46,992 DEBUG : BROWSER_OUTPUT: 10:11:49 INFO - 2015-11-11 10:11:49,559 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:34455/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:34455/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 10:11:50 INFO - 2015-11-11 10:11:50,141 DEBUG : BROWSER_OUTPUT: RSS: Main: 139964416 10:11:50 INFO - 2015-11-11 10:11:50,142 DEBUG : BROWSER_OUTPUT: 10:11:51 INFO - 2015-11-11 10:11:51,831 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:34455/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:34455/tests/kraken/driver.html?testName=ai-astar) 10:11:52 INFO - 2015-11-11 10:11:52,089 DEBUG : BROWSER_OUTPUT: RSS: Main: 138448896 10:11:52 INFO - 2015-11-11 10:11:52,089 DEBUG : BROWSER_OUTPUT: 10:11:52 INFO - 2015-11-11 10:11:52,089 DEBUG : BROWSER_OUTPUT: __start_tp_report 10:11:52 INFO - 2015-11-11 10:11:52,089 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 10:11:52 INFO - 2015-11-11 10:11:52,089 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 10:11:52 INFO - 2015-11-11 10:11:52,089 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 10:11:52 INFO - 2015-11-11 10:11:52,090 DEBUG : BROWSER_OUTPUT: |0;ai-astar;110;106;111;109;111;121;113;111;110;110 10:11:52 INFO - 2015-11-11 10:11:52,090 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;154;125;157;165;131;162;149;128;160;125 10:11:52 INFO - 2015-11-11 10:11:52,090 DEBUG : BROWSER_OUTPUT: |2;audio-dft;161;164;162;163;162;161;160;164;174;162 10:11:52 INFO - 2015-11-11 10:11:52,090 DEBUG : BROWSER_OUTPUT: |3;audio-fft;72;71;71;74;71;145;74;73;71;73 10:11:52 INFO - 2015-11-11 10:11:52,090 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;89;90;133;90;89;90;141;90;90;140 10:11:52 INFO - 2015-11-11 10:11:52,090 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;110;111;110;112;110;111;112;111;110;110 10:11:52 INFO - 2015-11-11 10:11:52,090 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;146;147;147;145;146;146;146;146;147;145 10:11:52 INFO - 2015-11-11 10:11:52,090 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;96;96;96;96;96;97;96;96;96;96 10:11:52 INFO - 2015-11-11 10:11:52,090 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;61;62;62;60;65;61;64;62;59;59 10:11:52 INFO - 2015-11-11 10:11:52,090 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;66;68;68;67;66;67;67;67;69;69 10:11:52 INFO - 2015-11-11 10:11:52,090 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;84;89;84;92;85;96;86;92;85;83 10:11:52 INFO - 2015-11-11 10:11:52,090 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;114;115;121;124;117;127;134;129;126;118 10:11:52 INFO - 2015-11-11 10:11:52,090 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;138;165;146;149;152;137;141;148;148;140 10:11:52 INFO - 2015-11-11 10:11:52,090 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;68;69;68;70;68;65;68;68;66;66 10:11:52 INFO - 2015-11-11 10:11:52,091 DEBUG : BROWSER_OUTPUT: __end_tp_report 10:11:52 INFO - 2015-11-11 10:11:52,091 DEBUG : BROWSER_OUTPUT: __start_cc_report 10:11:52 INFO - 2015-11-11 10:11:52,091 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,704 10:11:52 INFO - 2015-11-11 10:11:52,091 DEBUG : BROWSER_OUTPUT: __end_cc_report 10:11:52 INFO - 2015-11-11 10:11:52,091 DEBUG : BROWSER_OUTPUT: __startTimestamp1447265512083__endTimestamp 10:11:52 INFO - 2015-11-11 10:11:52,091 DEBUG : BROWSER_OUTPUT: 10:11:52 INFO - 2015-11-11 10:11:52,091 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 10:11:52 INFO - 2015-11-11 10:11:52,091 DEBUG : BROWSER_OUTPUT: Number of tests: 14 10:11:52 INFO - 2015-11-11 10:11:52,091 DEBUG : BROWSER_OUTPUT: 10:11:52 INFO - 2015-11-11 10:11:52,091 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:111.20 Median:111.00 stddev:3.88 (3.5%) stddev-sans-first:4.09 10:11:52 INFO - 2015-11-11 10:11:52,091 DEBUG : BROWSER_OUTPUT: Values: 110.0 106.0 111.0 109.0 111.0 121.0 113.0 111.0 110.0 110.0 10:11:52 INFO - 2015-11-11 10:11:52,092 DEBUG : BROWSER_OUTPUT: 10:11:52 INFO - 2015-11-11 10:11:52,092 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:145.60 Median:155.50 stddev:16.45 (10.6%) stddev-sans-first:17.17 10:11:52 INFO - 2015-11-11 10:11:52,092 DEBUG : BROWSER_OUTPUT: Values: 154.0 125.0 157.0 165.0 131.0 162.0 149.0 128.0 160.0 125.0 10:11:52 INFO - 2015-11-11 10:11:52,092 DEBUG : BROWSER_OUTPUT: 10:11:52 INFO - 2015-11-11 10:11:52,092 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:163.30 Median:162.50 stddev:3.97 (2.4%) stddev-sans-first:4.13 10:11:52 INFO - 2015-11-11 10:11:52,092 DEBUG : BROWSER_OUTPUT: Values: 161.0 164.0 162.0 163.0 162.0 161.0 160.0 164.0 174.0 162.0 10:11:52 INFO - 2015-11-11 10:11:52,093 DEBUG : BROWSER_OUTPUT: 10:11:52 INFO - 2015-11-11 10:11:52,093 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:79.50 Median:72.50 stddev:23.05 (31.8%) stddev-sans-first:24.28 10:11:52 INFO - 2015-11-11 10:11:52,093 DEBUG : BROWSER_OUTPUT: Values: 72.0 71.0 71.0 74.0 71.0 145.0 74.0 73.0 71.0 73.0 10:11:52 INFO - 2015-11-11 10:11:52,093 DEBUG : BROWSER_OUTPUT: 10:11:52 INFO - 2015-11-11 10:11:52,093 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:104.20 Median:90.00 stddev:23.42 (26.0%) stddev-sans-first:24.18 10:11:52 INFO - 2015-11-11 10:11:52,093 DEBUG : BROWSER_OUTPUT: Values: 89.0 90.0 133.0 90.0 89.0 90.0 141.0 90.0 90.0 140.0 10:11:52 INFO - 2015-11-11 10:11:52,093 DEBUG : BROWSER_OUTPUT: 10:11:52 INFO - 2015-11-11 10:11:52,093 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:110.70 Median:111.00 stddev:0.82 (0.7%) stddev-sans-first:0.83 10:11:52 INFO - 2015-11-11 10:11:52,095 DEBUG : BROWSER_OUTPUT: Values: 110.0 111.0 110.0 112.0 110.0 111.0 112.0 111.0 110.0 110.0 10:11:52 INFO - 2015-11-11 10:11:52,095 DEBUG : BROWSER_OUTPUT: 10:11:52 INFO - 2015-11-11 10:11:52,095 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:146.10 Median:146.00 stddev:0.74 (0.5%) stddev-sans-first:0.78 10:11:52 INFO - 2015-11-11 10:11:52,095 DEBUG : BROWSER_OUTPUT: Values: 146.0 147.0 147.0 145.0 146.0 146.0 146.0 146.0 147.0 145.0 10:11:52 INFO - 2015-11-11 10:11:52,095 DEBUG : BROWSER_OUTPUT: 10:11:52 INFO - 2015-11-11 10:11:52,095 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:96.10 Median:96.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 10:11:52 INFO - 2015-11-11 10:11:52,095 DEBUG : BROWSER_OUTPUT: Values: 96.0 96.0 96.0 96.0 96.0 97.0 96.0 96.0 96.0 96.0 10:11:52 INFO - 2015-11-11 10:11:52,095 DEBUG : BROWSER_OUTPUT: 10:11:52 INFO - 2015-11-11 10:11:52,095 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:61.50 Median:62.00 stddev:1.96 (3.2%) stddev-sans-first:2.07 10:11:52 INFO - 2015-11-11 10:11:52,096 DEBUG : BROWSER_OUTPUT: Values: 61.0 62.0 62.0 60.0 65.0 61.0 64.0 62.0 59.0 59.0 10:11:52 INFO - 2015-11-11 10:11:52,096 DEBUG : BROWSER_OUTPUT: 10:11:52 INFO - 2015-11-11 10:11:52,096 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:67.40 Median:67.50 stddev:1.07 (1.6%) stddev-sans-first:1.01 10:11:52 INFO - 2015-11-11 10:11:52,096 DEBUG : BROWSER_OUTPUT: Values: 66.0 68.0 68.0 67.0 66.0 67.0 67.0 67.0 69.0 69.0 10:11:52 INFO - 2015-11-11 10:11:52,096 DEBUG : BROWSER_OUTPUT: 10:11:52 INFO - 2015-11-11 10:11:52,096 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:87.60 Median:87.50 stddev:4.40 (5.0%) stddev-sans-first:4.47 10:11:52 INFO - 2015-11-11 10:11:52,096 DEBUG : BROWSER_OUTPUT: Values: 84.0 89.0 84.0 92.0 85.0 96.0 86.0 92.0 85.0 83.0 10:11:52 INFO - 2015-11-11 10:11:52,096 DEBUG : BROWSER_OUTPUT: 10:11:52 INFO - 2015-11-11 10:11:52,096 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:122.50 Median:125.00 stddev:6.59 (5.3%) stddev-sans-first:6.23 10:11:52 INFO - 2015-11-11 10:11:52,096 DEBUG : BROWSER_OUTPUT: Values: 114.0 115.0 121.0 124.0 117.0 127.0 134.0 129.0 126.0 118.0 10:11:52 INFO - 2015-11-11 10:11:52,096 DEBUG : BROWSER_OUTPUT: 10:11:52 INFO - 2015-11-11 10:11:52,096 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:146.40 Median:148.00 stddev:8.29 (5.6%) stddev-sans-first:8.22 10:11:52 INFO - 2015-11-11 10:11:52,096 DEBUG : BROWSER_OUTPUT: Values: 138.0 165.0 146.0 149.0 152.0 137.0 141.0 148.0 148.0 140.0 10:11:52 INFO - 2015-11-11 10:11:52,096 DEBUG : BROWSER_OUTPUT: 10:11:52 INFO - 2015-11-11 10:11:52,096 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.60 Median:68.00 stddev:1.51 (2.2%) stddev-sans-first:1.59 10:11:52 INFO - 2015-11-11 10:11:52,096 DEBUG : BROWSER_OUTPUT: Values: 68.0 69.0 68.0 70.0 68.0 65.0 68.0 68.0 66.0 66.0 10:11:52 INFO - 2015-11-11 10:11:52,097 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 10:11:52 INFO - 2015-11-11 10:11:52,097 DEBUG : BROWSER_OUTPUT: 10:11:52 INFO - 2015-11-11 10:11:52,993 INFO : Browser exited with error code: 0 10:11:53 INFO - 2015-11-11 10:11:53,048 INFO : Completed test kraken (00:00:59) 10:11:53 INFO - 2015-11-11 10:11:53,048 INFO : Starting test v8_7 10:11:53 INFO - 2015-11-11 10:11:53,048 DEBUG : operating with platform_type : linux_ 10:11:53 INFO - 2015-11-11 10:11:53,048 INFO : Initialising browser for v8_7 test... 10:11:53 INFO - 2015-11-11 10:11:53,054 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpL1psQg/profile http://localhost:34455/getInfo.html 10:11:57 INFO - 2015-11-11 10:11:57,231 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 10:11:57 INFO - 2015-11-11 10:11:57,231 DEBUG : BROWSER_OUTPUT: colorDepth:24 10:11:57 INFO - 2015-11-11 10:11:57,231 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 10:11:57 INFO - 2015-11-11 10:11:57,231 DEBUG : BROWSER_OUTPUT: __metrics 10:11:58 INFO - 2015-11-11 10:11:58,237 INFO : Browser initialized. 10:11:58 INFO - 2015-11-11 10:11:58,238 INFO : Running cycle 1/1 for v8_7 test... 10:11:58 INFO - 2015-11-11 10:11:58,238 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpL1psQg/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 10:12:10 INFO - 2015-11-11 10:12:10,011 DEBUG : BROWSER_OUTPUT: RSS: Main: 139243520 10:12:10 INFO - 2015-11-11 10:12:10,011 DEBUG : BROWSER_OUTPUT: 10:12:31 INFO - 2015-11-11 10:12:31,352 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:34455/tests/v8_7/run.html (next: http://localhost:34455/tests/v8_7/run.html) 10:12:31 INFO - 2015-11-11 10:12:31,610 DEBUG : BROWSER_OUTPUT: RSS: Main: 137916416 10:12:31 INFO - 2015-11-11 10:12:31,611 DEBUG : BROWSER_OUTPUT: 10:12:31 INFO - 2015-11-11 10:12:31,611 DEBUG : BROWSER_OUTPUT: __start_tp_report 10:12:31 INFO - 2015-11-11 10:12:31,611 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 10:12:31 INFO - 2015-11-11 10:12:31,611 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 10:12:31 INFO - 2015-11-11 10:12:31,611 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 10:12:31 INFO - 2015-11-11 10:12:31,611 DEBUG : BROWSER_OUTPUT: |0;Richards;169.83695652173913 10:12:31 INFO - 2015-11-11 10:12:31,611 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;191.8649270913277 10:12:31 INFO - 2015-11-11 10:12:31,612 DEBUG : BROWSER_OUTPUT: |2;Encrypt;282.0078962210942 10:12:31 INFO - 2015-11-11 10:12:31,612 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5030.150753768844 10:12:31 INFO - 2015-11-11 10:12:31,612 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1060.4453870625662 10:12:31 INFO - 2015-11-11 10:12:31,612 DEBUG : BROWSER_OUTPUT: |5;Earley;704.7216349541931 10:12:31 INFO - 2015-11-11 10:12:31,612 DEBUG : BROWSER_OUTPUT: |6;Boyer;11788.235294117647 10:12:31 INFO - 2015-11-11 10:12:31,612 DEBUG : BROWSER_OUTPUT: |7;RegExp;24853.658536585364 10:12:31 INFO - 2015-11-11 10:12:31,613 DEBUG : BROWSER_OUTPUT: |8;Splay;599.5203836930456 10:12:31 INFO - 2015-11-11 10:12:31,613 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4822.115384615385 10:12:31 INFO - 2015-11-11 10:12:31,613 DEBUG : BROWSER_OUTPUT: __end_tp_report 10:12:31 INFO - 2015-11-11 10:12:31,613 DEBUG : BROWSER_OUTPUT: __startTimestamp1447265551603__endTimestamp 10:12:31 INFO - 2015-11-11 10:12:31,614 DEBUG : BROWSER_OUTPUT: 10:12:31 INFO - 2015-11-11 10:12:31,614 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 10:12:31 INFO - 2015-11-11 10:12:31,614 DEBUG : BROWSER_OUTPUT: Number of tests: 10 10:12:31 INFO - 2015-11-11 10:12:31,614 DEBUG : BROWSER_OUTPUT: 10:12:31 INFO - 2015-11-11 10:12:31,614 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:169.84 Median:169.84 stddev:0.00 (0.0%) 10:12:31 INFO - 2015-11-11 10:12:31,614 DEBUG : BROWSER_OUTPUT: Values: 169.8 10:12:31 INFO - 2015-11-11 10:12:31,614 DEBUG : BROWSER_OUTPUT: 10:12:31 INFO - 2015-11-11 10:12:31,615 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:191.86 Median:191.86 stddev:0.00 (0.0%) 10:12:31 INFO - 2015-11-11 10:12:31,615 DEBUG : BROWSER_OUTPUT: Values: 191.9 10:12:31 INFO - 2015-11-11 10:12:31,615 DEBUG : BROWSER_OUTPUT: 10:12:31 INFO - 2015-11-11 10:12:31,615 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:282.01 Median:282.01 stddev:0.00 (0.0%) 10:12:31 INFO - 2015-11-11 10:12:31,615 DEBUG : BROWSER_OUTPUT: Values: 282.0 10:12:31 INFO - 2015-11-11 10:12:31,615 DEBUG : BROWSER_OUTPUT: 10:12:31 INFO - 2015-11-11 10:12:31,615 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5030.15 Median:5030.15 stddev:0.00 (0.0%) 10:12:31 INFO - 2015-11-11 10:12:31,616 DEBUG : BROWSER_OUTPUT: Values: 5030.2 10:12:31 INFO - 2015-11-11 10:12:31,616 DEBUG : BROWSER_OUTPUT: 10:12:31 INFO - 2015-11-11 10:12:31,616 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1060.45 Median:1060.45 stddev:0.00 (0.0%) 10:12:31 INFO - 2015-11-11 10:12:31,616 DEBUG : BROWSER_OUTPUT: Values: 1060.4 10:12:31 INFO - 2015-11-11 10:12:31,616 DEBUG : BROWSER_OUTPUT: 10:12:31 INFO - 2015-11-11 10:12:31,616 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:704.72 Median:704.72 stddev:0.00 (0.0%) 10:12:31 INFO - 2015-11-11 10:12:31,616 DEBUG : BROWSER_OUTPUT: Values: 704.7 10:12:31 INFO - 2015-11-11 10:12:31,617 DEBUG : BROWSER_OUTPUT: 10:12:31 INFO - 2015-11-11 10:12:31,617 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:11788.24 Median:11788.24 stddev:0.00 (0.0%) 10:12:31 INFO - 2015-11-11 10:12:31,617 DEBUG : BROWSER_OUTPUT: Values: 11788.2 10:12:31 INFO - 2015-11-11 10:12:31,617 DEBUG : BROWSER_OUTPUT: 10:12:31 INFO - 2015-11-11 10:12:31,617 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:24853.66 Median:24853.66 stddev:0.00 (0.0%) 10:12:31 INFO - 2015-11-11 10:12:31,617 DEBUG : BROWSER_OUTPUT: Values: 24853.7 10:12:31 INFO - 2015-11-11 10:12:31,617 DEBUG : BROWSER_OUTPUT: 10:12:31 INFO - 2015-11-11 10:12:31,617 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:599.52 Median:599.52 stddev:0.00 (0.0%) 10:12:31 INFO - 2015-11-11 10:12:31,617 DEBUG : BROWSER_OUTPUT: Values: 599.5 10:12:31 INFO - 2015-11-11 10:12:31,617 DEBUG : BROWSER_OUTPUT: 10:12:31 INFO - 2015-11-11 10:12:31,617 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4822.12 Median:4822.12 stddev:0.00 (0.0%) 10:12:31 INFO - 2015-11-11 10:12:31,617 DEBUG : BROWSER_OUTPUT: Values: 4822.1 10:12:31 INFO - 2015-11-11 10:12:31,618 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 10:12:31 INFO - 2015-11-11 10:12:31,618 DEBUG : BROWSER_OUTPUT: 10:12:32 INFO - 2015-11-11 10:12:32,461 INFO : Browser exited with error code: 0 10:12:32 INFO - 2015-11-11 10:12:32,480 INFO : Completed test v8_7 (00:00:39) 10:12:32 INFO - 2015-11-11 10:12:32,648 INFO : Completed test suite (00:20:10) 10:12:32 INFO - 2015-11-11 10:12:32,648 DEBUG : Working with test: dromaeo_css 10:12:32 INFO - 2015-11-11 10:12:32,648 DEBUG : Generating results file: dromaeo_css 10:12:32 INFO - 2015-11-11 10:12:32,649 DEBUG : Working with test: kraken 10:12:32 INFO - 2015-11-11 10:12:32,650 DEBUG : Generating results file: kraken 10:12:32 INFO - 2015-11-11 10:12:32,650 INFO : javascript benchmark 10:12:32 INFO - 2015-11-11 10:12:32,650 DEBUG : Working with test: v8_7 10:12:32 INFO - 2015-11-11 10:12:32,650 DEBUG : Generating results file: v8_7 10:12:32 INFO - 2015-11-11 10:12:32,651 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 10:12:32 INFO - 2015-11-11 10:12:32,712 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,64,43]] 10:12:32 INFO - 2015-11-11 10:12:32,712 DEBUG : process_Request line: dromaeo_css 6956.36 graph.html#tests=[[72,64,43]] 10:12:32 INFO - 2015-11-11 10:12:32,713 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 10:12:32 INFO - 2015-11-11 10:12:32,753 DEBUG : process_Request line: kraken 1509.70 graph.html#tests=[[232,64,43]] 10:12:32 INFO - 2015-11-11 10:12:32,753 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 10:12:32 INFO - 2015-11-11 10:12:32,784 DEBUG : process_Request line: v8_7 21517.03 graph.html#tests=[[230,64,43]] 10:12:32 INFO - 2015-11-11 10:12:32,786 INFO : javascript benchmark 10:12:32 INFO - 2015-11-11 10:12:32,790 INFO : TALOSDATA: [{"talos_counters": {}, "results": {"jquery.html": [344.2787360479796, 344.4127762165508, 350.73869966874685, 355.0679466400698, 357.41919381005874, 11210.775784484305, 11561.884381156186, 16846.32614695412, 17077.743833842487, 17839.197236124357, 18132.18405171767, 18183.09084545774, 18447.907760461214, 18585.628287434243, 18645.16096775645, 5897.646141231529, 6082.300535438415, 6082.300535438437, 6087.4825639820665, 6106.664133472657, 6029.427204415573, 6044.093385992092, 6058.485028772538, 6284.308726040132, 6477.54657173998, 6394.744210231585, 6413.967930160343, 6445.645489498076, 6455.128557644728, 6642.966785166067, 6454.483641308731, 6577.144971153743, 6606.405423511883, 6630.933690663104, 6855.4172895303955, 6577.506686998494, 6581.2760596334365, 6582.17722784652, 6593.3736295051895, 6598.769043083469, 20792.16831326745, 21178.470538236666, 21633.56732865334, 21797.237096701538, 21930.342089737333, 2103.6108319960704, 2120.713703650003, 2218.633925402307, 2220.134147682405, 2380.3811009137576, 14282.785758213635, 14448.638784030378, 14552.417903283962, 14567.125972441687, 14763.188024658639, 1850.518865095085, 1858.5353661584604, 1877.220953304377, 1949.4444083436294, 1997.5805080933021, 68287.0, 70047.2995270046, 70068.79587224731, 70595.64702176508, 72071.0, 16188.109653969144, 16331.673366532603, 16349.0, 16464.588385290223, 16477.423290185026, 23785.881070594536, 23928.641070383957, 24367.0, 24386.0, 24450.655213963048, 8718.215360617574, 8862.822743545223, 8887.73336799897, 8925.062868398854, 8952.060033696369, 7026.367626913602, 7035.155781306276, 7060.7881763547175, 7125.501214914906, 7428.4428667850125, 7995.840083198304, 8075.838483230303, 8136.959315203386, 8206.93309869713, 8210.753677389688, 1239.9194052386747, 3200.0, 3298.686624770643, 3302.6862448067395, 3305.4380755271663, 471.6062088156359, 483.1255427675918, 493.33646245799343, 513.8175947538645, 530.0432718942346, 11049.508316377347, 11236.157288203418, 11730.472128754227, 11939.52241910314, 12056.75886482283, 490.0786521339858, 495.7744226377062, 497.5546885537424, 501.07551567358166, 522.2036394498421, 6666.333366663392, 6758.357955994173, 6844.4182244509775, 6856.485763567753, 6950.443964482829, 518585.0, 522895.0, 531643.0, 533711.0, 535058.6494135009, 80890.59554702189, 81709.0, 82119.17880821235, 82687.58656206801, 82712.58643706863, 522.339240860312, 525.2331595870072, 526.6445149524056, 528.1206790693452, 544.1810075835921, 10935.773946685587, 11148.219624626197, 11175.944120279346, 11218.719532011764, 11283.605073822377, 33634.0, 36069.63930360663, 36948.261034779694, 37305.81347093247, 37486.2502749938, 42334.153316934106, 43904.56095439005, 44518.55481445144, 48764.51235487741, 49258.26112608385, 6932.61870597122, 6954.3393377629045, 6979.40675042627, 7014.579125252501, 7063.646817658993, 12662.366881656064, 12812.61562153137, 13051.543195988095, 13074.542391016268, 13075.607731768063, 10363.585456581652, 10373.948130259301, 11076.224664273746, 11391.601293954673, 11434.313941163557, 10700.785984280426, 11009.779804403706, 11189.104871610414, 11267.605633802777, 11278.887211127783, 11199.21605487608, 11313.71715707081, 11390.088792896382, 11560.0, 11576.131790115944, 6930.237673855771, 7001.964990175016, 7006.649667516502, 7018.649067546704, 7026.859462810818, 11138.10895128404, 11200.495977680861, 11201.775964480501, 11252.156088293574, 11290.830637540608], "dojo.html": [3226.9677303226968, 3335.4496508076168, 3359.6304406515296, 3376.3584918865413, 3381.814000229988, 5370.087085195516, 5522.088855338874, 5534.2252084708125, 5541.63979341343, 5559.916601250984, 5441.972790136044, 5483.067878460662, 5517.503424691777, 5542.0301447246775, 5559.805406810752, 5007.298978143054, 5079.111155547765, 5132.435432102466, 5157.793688252485, 5158.587313014949, 5080.339555857733, 5158.845234642967, 5167.509086636783, 5172.19830926207, 5197.116490196676, 4924.4090709115135, 4951.331570238026, 4951.653384263103, 5033.471485494007, 5045.949540504585, 5032.0, 5039.697618142924, 5050.116229659795, 5075.0, 5096.643234973553, 5016.724080175589, 5042.924356134661, 5046.394432668103, 5047.116754567936, 5068.265101560253, 5012.1980483122525, 5141.820036298712, 5144.485551444863, 5214.713190774506, 5215.348081489814, 5930.05119180929, 5974.253218347707, 5978.461938425519, 5988.940110598882, 5995.1906492623375, 5798.7100644968, 5995.880082398327, 6005.249343832021, 6006.039033754579, 6015.09773533969, 5465.4261302563455, 5523.889522209533, 5529.861753456155, 5529.944700553024, 5548.916766248469, 6082.75668973245, 6089.056196289582, 6101.005087479836, 6118.1128736332985, 6139.553468857771, 5855.355910849803, 5895.852603684856, 5911.113333000085, 5920.845435140192, 5940.940590594038, 5671.6597004179885, 5824.155497452845, 5872.500837428781, 5972.820815375546, 6006.579539432285, 5931.1992880960515, 6011.068284415923, 6017.939820601826, 6020.157177995085, 6028.306744724325, 5986.880262394815, 5992.490638295706, 5994.07091900756, 6009.609375390585, 6023.367546407651, 4393.472783266028, 4472.44094488189, 4475.888102797391, 4520.683552151384, 4577.221872281653, 4050.6556942659613, 4059.0867054913, 4078.6940979426663, 4128.896777580524, 4140.855070072533, 5391.137418013099, 5750.971245143747, 5760.0783874579865, 5774.595778295563, 5775.422457754191, 5830.591858569859, 5884.676342801187, 5945.851353716192, 5971.492423144082, 6003.7898673546215, 5610.719464026783, 5639.0977443609645, 5644.0, 5660.632058916157, 5686.630369026, 4995.475475075137, 5098.796048158107, 5169.043726910533, 5188.11801993662, 5189.221616757441, 6046.2139921809885, 6116.061877111514, 6132.600268413531, 6134.834601026089, 6140.565599444434, 6010.368911264429, 6015.157877897185, 6016.548758843017, 6021.066734656135, 6069.180660610761, 5845.18167456548, 5969.492593129633, 5995.250593675791, 6239.4696450800375, 6263.0, 5889.293284805851, 5890.145928840208, 5898.852528686817, 5905.084711869667, 5929.814037192665, 5932.614380065282, 5934.554908381802, 5937.465628093492, 5941.673207973603, 5945.672987985702, 5625.071863142535, 5741.741621626953, 5748.45389687979, 5814.098814683731, 5882.676452794966, 5666.490015898589, 5873.676947767743, 5885.61743486672, 5887.558433117619, 5903.085021821625, 5744.138379243147, 5774.220480235114, 5790.131480277992, 5790.507806836466, 5791.507721843691, 5626.718664066862, 5752.511036561772, 5761.48146666802, 5851.941480585139, 5880.735366908414, 5677.914831277617, 5700.287464066992, 5720.914186287126, 5723.942760572341, 5725.055365864586], "mootools.html": [1516.2039929037262, 1725.284007137038, 1737.18352374384, 1778.3064604804122, 1799.1543974332064, 7281.563106213631, 7541.396688264933, 7608.239176082389, 7623.771286861389, 7926.762197134095, 7564.886526702104, 7601.0, 7631.313181813635, 7675.078990521145, 7682.5006374585755, 2207.073029327686, 2239.7536271010176, 2241.3948233976816, 2244.06871148474, 2244.2706120510816, 2301.2981040782556, 2303.79265866072, 2343.343863718153, 2344.589696803061, 2351.247600767755, 2198.8565945708224, 2216.501287210373, 2229.665550167472, 2261.366817291153, 2270.965935510969, 2261.9208327708616, 2275.8975846086964, 2317.24689475921, 2326.1858349577683, 2336.4158960259933, 2278.920237791686, 2305.6772051912744, 2324.4537533679572, 2328.161861729776, 2335.6730057791924, 7596.506227095221, 7680.654370553339, 7722.652480638385, 7742.806429839243, 7778.64996075178, 4590.3344015117955, 4650.883727906796, 4670.9065818683775, 4689.88275293117, 4709.788059537329, 2960.407918416325, 2974.092901664991, 3016.9849150754326, 3039.6352437707396, 3059.35753491767, 944.390867890207, 948.0850978805416, 983.4689267795382, 984.3945973226486, 988.6391467114523, 10423.322484038514, 10466.11038061758, 10498.37009779408, 10504.2647014709, 10559.947200264027, 4096.959030409717, 4152.1695660867945, 4175.436316097288, 4176.624103830609, 4192.580741925783, 8484.618192181366, 8537.615807288686, 8563.914360856312, 8564.057953625097, 8573.22840944318, 4574.931376029363, 4627.444706635225, 4634.397528321297, 4638.443386793607, 4641.0, 4210.705250632426, 4286.5284818669925, 4299.290617048152, 4310.762908040025, 4326.0, 3312.585926759155, 3362.2434952136064, 3366.5118557808983, 3367.1413789483527, 3388.034410193083, 1057.0592172966067, 1094.6661268313082, 1098.077614803553, 1110.5113749949996, 1115.0800589513683, 1020.974475638115, 1025.5487585462372, 1072.0030371754344, 1191.1959427386653, 1349.9942542805672, 7116.217216106224, 7193.992841002264, 7197.568145911262, 7215.855682886313, 7224.988501609779, 1077.342820879263, 1082.2694681090234, 1085.842552829851, 1087.907527860125, 1118.5693507999315, 5651.8304450866535, 5709.65742055478, 5722.399148089391, 5722.484976352148, 5752.597318187687, 9126.0, 9134.269258459308, 9164.816703665889, 9174.036726143791, 9349.859752103725, 9212.447253164832, 9223.400478968846, 9261.212796912203, 9266.397684150508, 9280.7679808004, 7080.398166155832, 7111.324424179695, 7183.92816071843, 7193.064901562868, 7221.855562888818, 6812.591244525344, 6856.41720453767, 6876.518643694893, 6879.071325371011, 6881.552699074544, 7864.84270314602, 8091.676332946617, 8203.58982050907, 8269.917300826915, 8301.709440169565, 8165.14266002085, 8270.37972152103, 8315.0, 8321.12628174033, 8366.0, 6638.900416493853, 6669.699863506251, 6757.0, 6797.592144471348, 6839.487038472035, 7623.390128789572, 7633.465657403928, 7637.274458926393, 7670.923290767021, 7694.499857509244, 6970.302969702989, 7033.788986330418, 7123.145222573325, 7204.171520275026, 7252.41980641558, 6829.829254268683, 6995.405390541861, 7018.33325834045, 7070.1869285030825, 7141.714331426685, 7000.054992576141, 7066.081409416743, 7099.0, 7103.786886393416, 7118.893216601651, 6279.654618995999, 6320.936790632035, 6349.841253968688, 6358.650274234961, 6374.617522948638, 6366.236051673829, 6420.101185834081, 6437.452816510649, 6447.484201263981, 6465.094886715958], "ext.html": [566.9546436285096, 574.8649067469144, 584.1763114009245, 589.4370875813596, 593.3236110833648, 39468.0, 40340.0, 40358.192836143295, 40458.0, 40495.79752101239, 43188.784056079756, 43470.56529434705, 43748.78125609367, 43772.12455750883, 43791.56208437915, 8779.517126558037, 8899.33255005874, 8900.554972251362, 8906.599203035847, 8919.108089191093, 8675.08911564286, 8704.129587041278, 8792.648294068229, 8797.0, 8804.86792698107, 8684.348673849456, 8749.081346458626, 8788.912110878873, 8794.252488538483, 8814.647414103429, 8765.123487651248, 8804.823903521925, 8829.337799664987, 8837.690680826205, 8846.071162527971, 8647.264982476434, 8702.869456958151, 8740.0, 8778.692745753868, 8782.38523303369, 40179.39730904039, 40292.79853600713, 40309.19381612381, 40357.789266322055, 40440.39339409911, 3288.145082278601, 3586.7130629549574, 3618.7285953553323, 3700.2229531798353, 3941.625545573166, 29932.401351973058, 30229.0, 30325.24186895323, 30446.84776576103, 30829.0, 3193.4411477991257, 3248.626407963091, 3274.8526316315824, 3304.983475082633, 3356.87544672535, 266489.0, 269095.999999998, 269120.0, 269788.0, 270226.0, 56816.71591642015, 57705.71147144322, 58345.0, 58649.41350586525, 58742.41257587455, 68263.0, 68333.31666683369, 68408.3159168412, 68928.6553567229, 69273.65363173152, 13977.72044559103, 14292.285385730673, 14308.141511509342, 14323.713525729427, 14336.569902902722, 10456.0, 10462.947685261524, 10491.947540262403, 10534.209934254808, 10558.419286939292, 19710.507237318896, 20037.398878033684, 20038.198472060954, 20059.0, 20069.39791806219, 7491.737789177353, 7505.211952744992, 7599.354054905284, 7629.427792915553, 7727.690892364242, 868.6221493650156, 917.7063339731355, 929.7907970706536, 934.9953250233706, 965.6185806606351, 28223.858880705466, 28277.15168544947, 28482.857585712354, 28778.424431511252, 28998.0, 989.6684610655367, 990.0643891522586, 1098.961536346224, 1121.1423261205184, 1126.985712858434, 13926.860731392557, 15368.231588420535, 15730.606734831721, 16095.275712592962, 16495.34018639241, 324612.0, 324622.0, 328825.0, 328965.0, 329860.0, 52414.213786793225, 53218.201726974126, 53243.0, 53285.0, 53423.0, 1313.8883194928537, 1362.1010133312166, 1377.455904917552, 1378.0973462382156, 1380.0339762166523, 28174.43651127007, 29273.7072629271, 29276.121716348545, 29319.267018324714, 29548.261293467836, 46364.76817616025, 46642.0, 46662.76668616635, 46785.0, 46935.06129877452, 308849.0, 312827.0, 314114.0, 314604.0, 315458.0, 31362.372752544365, 32569.0, 32874.0, 32968.0, 33197.83401082979, 41847.37228941507, 42819.357709633754, 43226.0, 43731.34402984021, 44344.11311773811, 36255.81872090622, 36464.0, 36690.44964325591, 36919.26161476809, 37440.251194976496, 36262.4560631596, 36681.165941703344, 36825.26349473049, 36858.0, 37081.62918370782, 35612.28775424425, 35712.28575428425, 35715.0, 35795.82102089473, 36007.45988810118, 30302.84848575743, 32995.175120622174, 32999.50500742539, 33146.83426582852, 33201.50197747084, 25018.62472062957, 25274.87362563249, 25340.11309604155, 25613.61579576345, 25664.101756438435], "prototype.html": [320.95185722141673, 326.79085385353363, 329.90267870978073, 331.4597206553318, 340.984655690494, 6047.6976151192375, 6072.180255665484, 6077.209962704847, 6084.361142080079, 6157.661328626935, 5960.970195149018, 5985.940140598593, 5991.101334799782, 5995.550333724967, 5996.070609055603, 4548.2495388260895, 4557.544245575449, 4560.589546940775, 4570.748608826513, 4571.588557029867, 4557.156925968689, 4559.430071241095, 4561.042181141947, 4567.566081222279, 4571.977140114294, 4443.044745379742, 4508.2561377372695, 4546.499885012646, 4587.564181402778, 4607.677462577621, 4572.885677858047, 4579.107074120548, 4584.312353147021, 4595.586397224232, 4611.19304121779, 3965.7025723070597, 3976.960230397688, 3980.383040628707, 3986.40203969404, 3996.040950171967, 5708.71456427177, 5728.026235539926, 5731.455511726379, 5736.024875771129, 5743.368229494752, 5147.716875571842, 5226.52961233487, 5247.344081989751, 5294.761735721863, 5329.227262046981, 6273.937260627426, 6276.843078923018, 6279.058141278799, 6283.277423096357, 6288.151099601587, 4300.247456695097, 4314.9784251078545, 4321.24378233811, 4330.090680957002, 4344.500382456026, 6379.36206379363, 6477.417032467053, 6486.837829054264, 6522.249941256721, 6522.869542609169, 4503.347014682919, 4504.887377815581, 4509.7970591323465, 4518.81924723014, 4528.117017181684, 4566.109608626286, 4575.107853968444, 4576.679632425765, 4580.770961451914, 4582.702124361906, 5300.787968481218, 5302.443243459381, 5305.814296499604, 5308.840734777963, 5315.123004704181, 6275.058741188858, 6354.078658594478, 6398.680065996681, 6403.775867844603, 6427.2929977702415, 1610.4443966831425, 1629.055148014149, 1629.0958518022612, 1630.1115891838976, 1661.7008938390964, 1094.6661268313242, 1100.6697990602947, 1103.674416047268, 1109.2346281066039, 1118.0664145438486, 6086.756529738761, 6091.9695401523595, 6092.268927728613, 6097.8475538111015, 6106.236720409949, 6405.6797160141805, 6419.229692436844, 6429.58207716497, 6473.870522589522, 6474.061261117112, 6035.245594300713, 6152.261728592597, 6195.16365290689, 6201.348858369896, 6206.565540412128, 3645.325614761278, 3646.1431563582537, 3671.908202294964, 3672.137047793766, 3672.467492213614, 6811.693473793691, 6827.044213810071, 6828.556143850634, 6837.521373503906, 6853.074834897225, 6589.077529145828, 6740.325967403319, 6742.123523941857, 6748.696308666122, 6754.18949726036, 6788.083608712859, 6858.211305699909, 6862.656867156622, 6863.691133898987, 6869.381755642016, 6543.476521878333, 6555.344465553407, 6560.737570497317, 6563.474922006323, 6571.901421478778, 6374.968125159345, 6505.2844187138435, 6508.902366464602, 6510.609363438209, 6512.73949042033, 6800.625965571941, 6802.115724955724, 6802.455803535607, 6824.93175068243, 6832.863342733217, 4502.57225563571, 4506.616937560213, 4508.549145085465, 4511.233090374579, 4535.478419981744, 6470.094186813756, 6498.967505162444, 6508.544401892012, 6525.086487891604, 6562.245341785565, 6382.521310901608, 6386.616802991835, 6412.647304398303, 6413.230412350548, 6415.069814876723, 6325.367463253638, 6327.715252813542, 6329.778457753957, 6367.554271200971, 6369.235691717024, 6133.9079913802225, 6187.3503282154725, 6204.689765511616, 6255.71849266775, 6267.717952692231, 6448.903266450913, 6455.741770329322, 6487.22153341602, 6524.217093948757, 6534.019897015486, 6354.6822658867795, 6359.046143078575, 6359.8092057238355, 6369.426751592379, 6391.105245265573], "yui.html": [729.9854002919942, 768.4198430185211, 816.5631387207845, 817.4563914996528, 835.6991483066091, 13246.07277490576, 13507.79738303925, 13514.526991555298, 13535.18788872666, 13621.931890340558, 11356.602518911839, 12087.395630218498, 12280.385980700974, 12511.624651260454, 13176.341182940838, 821.1501096365248, 833.6207025803275, 835.4736515994945, 836.0135040652028, 836.2557323981662, 813.6948644258404, 824.1758241758242, 829.0217543298905, 830.0578843013193, 830.4104086098877, 866.6879923227633, 868.1231955724701, 870.447265986097, 872.7948932001007, 875.120503893586, 867.9869801952975, 869.5391442535466, 869.6825658634616, 870.190722627959, 873.5370253765515, 630.1083966187839, 633.6768248193408, 634.3941535833268, 634.6287421858218, 635.5487603801307, 12560.623181304576, 12609.369531523478, 12617.810732839014, 12621.116521843474, 12644.747105057939, 10640.361578305248, 10701.678949631445, 10803.78392432147, 10811.675649730521, 10845.0, 10266.538005789758, 10278.22913281507, 10305.227107966932, 10480.161587073017, 10526.894731052667, 3292.0, 3346.966530334714, 3353.6143343515564, 3362.159460134966, 3365.9831700841582, 45130.32304515435, 45959.540404595864, 46220.075598488176, 46336.304955425694, 46360.53639463596, 7725.613719314012, 7732.381409487228, 7757.301842834172, 7779.844403111906, 7887.171846956102, 12609.684757881127, 12701.0, 12735.490580376867, 12776.61670149897, 12802.743945121045, 6725.697343619451, 6778.0, 6806.319368063154, 7068.11648543932, 7074.469414793808, 4416.249237629547, 4460.241758900995, 4516.390287311171, 4535.7732113394195, 4603.125406172817, 2787.108125399893, 2794.2734888929026, 2795.1335086123368, 2818.1968139080263, 2829.915102546927, 446.8525386622407, 448.68591985610203, 453.2792859353578, 488.1043285570946, 500.3445486412811, 537.3471232452589, 605.9244840408222, 628.2335550628226, 679.2188982669969, 717.8923161525709, 8322.753140450188, 8772.166644168794, 8864.822703546022, 8888.866667, 8891.612607495552, 540.3866611396094, 565.4229016114546, 576.4523702482659, 629.8899679590708, 680.323078536859, 4031.677465802729, 4042.939355909664, 4190.099128687286, 4198.718747663134, 4380.8685739427865, 59743.0, 60356.39643603508, 60592.0, 60643.0, 60741.39258607446, 51415.48584514107, 51665.741671291406, 51832.0, 51960.0, 52081.21878171831, 46690.0, 47156.0, 47404.288935665994, 47539.0, 48534.0, 8713.411163152865, 8888.60001299956, 8970.461772293422, 9013.639454422011, 9020.323475739215, 35563.288734224654, 36078.27843443064, 36174.0, 36238.09404764902, 36865.815670921475, 44745.0, 46486.0, 46897.76551117223, 47215.29177062278, 47317.76341118272, 8546.914530854612, 8621.69824056155, 8659.87010194835, 8949.32880034013, 9068.90931090707, 11918.510510031709, 12045.51817927273, 12224.144309898222, 12452.564160254347, 12836.486540538273, 11313.20807543464, 11460.94269528647, 11478.483468243781, 11867.584634538096, 11879.10906681985, 10745.623903163665, 10870.891291087304, 10915.508802103766, 11047.116230701686, 11428.82602798025, 10988.615398461016, 11197.72005699864, 11341.489632966372, 11702.824457633313, 11742.236754610924, 9462.148406643435, 9638.0, 9776.951115244377, 9788.510574471391, 9967.252456065678, 9175.66510367089, 9290.210332121846, 9637.18083962843, 9748.268879833899, 9760.609575616896]}, "summary": {"lowerIsBetter": false, "suite": 6956.3623448244, "subtests": {"jquery.html": {"lowerIsBetter": false, "filtered": 8607.938459126803, "unit": "ms", "value": 8607.938459126803}, "dojo.html": {"lowerIsBetter": false, "filtered": 5476.919540292684, "unit": "ms", "value": 5476.919540292684}, "mootools.html": {"lowerIsBetter": false, "filtered": 4429.941871747823, "unit": "ms", "value": 4429.941871747823}, "ext.html": {"lowerIsBetter": false, "filtered": 18563.09598522419, "unit": "ms", "value": 18563.09598522419}, "prototype.html": {"lowerIsBetter": false, "filtered": 4802.939501013364, "unit": "ms", "value": 4802.939501013364}, "yui.html": {"lowerIsBetter": false, "filtered": 6085.044091196149, "unit": "ms", "value": 6085.044091196149}}}, "test_machine": {"platform": "x86_64", "osversion": "Ubuntu 12.04.e", "os": "linux", "name": "talos-linux64-ix-009.e"}, "testrun": {"date": 1447264341, "suite": "dromaeo_css", "options": {"responsiveness": false, "tpmozafterpaint": false, "tpchrome": true, "tppagecycles": 1, "tpcycles": 1, "tprender": false, "shutdown": false, "cycles": 1, "rss": false}}, "test_build": {"name": "Firefox", "version": "45.0a1", "id": "20151111083010", "branch": "Fx-Team", "revision": "e402ff476e1b9ff5764aeec44442ab3213c2efc6"}}, {"talos_counters": {}, "results": {"audio-dft": [161.0, 164.0, 162.0, 163.0, 162.0, 161.0, 160.0, 164.0, 174.0, 162.0], "ai-astar": [110.0, 106.0, 111.0, 109.0, 111.0, 121.0, 113.0, 111.0, 110.0, 110.0], "imaging-gaussian-blur": [110.0, 111.0, 110.0, 112.0, 110.0, 111.0, 112.0, 111.0, 110.0, 110.0], "audio-beat-detection": [154.0, 125.0, 157.0, 165.0, 131.0, 162.0, 149.0, 128.0, 160.0, 125.0], "json-stringify-tinderbox": [66.0, 68.0, 68.0, 67.0, 66.0, 67.0, 67.0, 67.0, 69.0, 69.0], "stanford-crypto-pbkdf2": [138.0, 165.0, 146.0, 149.0, 152.0, 137.0, 141.0, 148.0, 148.0, 140.0], "json-parse-financial": [61.0, 62.0, 62.0, 60.0, 65.0, 61.0, 64.0, 62.0, 59.0, 59.0], "stanford-crypto-sha256-iterative": [68.0, 69.0, 68.0, 70.0, 68.0, 65.0, 68.0, 68.0, 66.0, 66.0], "audio-fft": [72.0, 71.0, 71.0, 74.0, 71.0, 145.0, 74.0, 73.0, 71.0, 73.0], "imaging-darkroom": [146.0, 147.0, 147.0, 145.0, 146.0, 146.0, 146.0, 146.0, 147.0, 145.0], "stanford-crypto-ccm": [114.0, 115.0, 121.0, 124.0, 117.0, 127.0, 134.0, 129.0, 126.0, 118.0], "audio-oscillator": [89.0, 90.0, 133.0, 90.0, 89.0, 90.0, 141.0, 90.0, 90.0, 140.0], "stanford-crypto-aes": [84.0, 89.0, 84.0, 92.0, 85.0, 96.0, 86.0, 92.0, 85.0, 83.0], "imaging-desaturate": [96.0, 96.0, 96.0, 96.0, 96.0, 97.0, 96.0, 96.0, 96.0, 96.0]}, "summary": {"lowerIsBetter": true, "suite": 1509.7, "subtests": {"audio-fft": {"lowerIsBetter": true, "filtered": 79.5, "unit": "ms", "value": 79.5}, "stanford-crypto-pbkdf2": {"lowerIsBetter": true, "filtered": 146.4, "unit": "ms", "value": 146.4}, "audio-beat-detection": {"lowerIsBetter": true, "filtered": 145.6, "unit": "ms", "value": 145.6}, "stanford-crypto-ccm": {"lowerIsBetter": true, "filtered": 122.5, "unit": "ms", "value": 122.5}, "imaging-darkroom": {"lowerIsBetter": true, "filtered": 146.1, "unit": "ms", "value": 146.1}, "json-parse-financial": {"lowerIsBetter": true, "filtered": 61.5, "unit": "ms", "value": 61.5}, "audio-oscillator": {"lowerIsBetter": true, "filtered": 104.2, "unit": "ms", "value": 104.2}, "ai-astar": {"lowerIsBetter": true, "filtered": 111.2, "unit": "ms", "value": 111.2}, "audio-dft": {"lowerIsBetter": true, "filtered": 163.3, "unit": "ms", "value": 163.3}, "stanford-crypto-sha256-iterative": {"lowerIsBetter": true, "filtered": 67.6, "unit": "ms", "value": 67.6}, "json-stringify-tinderbox": {"lowerIsBetter": true, "filtered": 67.4, "unit": "ms", "value": 67.4}, "imaging-gaussian-blur": {"lowerIsBetter": true, "filtered": 110.7, "unit": "ms", "value": 110.7}, "stanford-crypto-aes": {"lowerIsBetter": true, "filtered": 87.6, "unit": "ms", "value": 87.6}, "imaging-desaturate": {"lowerIsBetter": true, "filtered": 96.1, "unit": "ms", "value": 96.1}}}, "test_machine": {"platform": "x86_64", "osversion": "Ubuntu 12.04.e", "os": "linux", "name": "talos-linux64-ix-009.e"}, "testrun": {"date": 1447264341, "suite": "kraken", "options": {"responsiveness": false, "tpmozafterpaint": false, "tpchrome": true, "tppagecycles": 1, "tpcycles": 1, "tprender": false, "shutdown": false, "cycles": 1, "rss": false}}, "test_build": {"name": "Firefox", "version": "45.0a1", "id": "20151111083010", "branch": "Fx-Team", "revision": "e402ff476e1b9ff5764aeec44442ab3213c2efc6"}}, {"talos_counters": {}, "results": {"DeltaBlue": [191.8649270913277], "Encrypt": [282.0078962210942], "NavierStokes": [4822.115384615385], "Decrypt": [5030.150753768844], "Splay": [599.5203836930456], "Richards": [169.83695652173913], "RegExp": [24853.658536585364], "Earley": [704.7216349541931], "Boyer": [11788.235294117647], "RayTrace": [1060.4453870625662]}, "summary": {"lowerIsBetter": false, "suite": 21517.02500978087, "subtests": {"DeltaBlue": {"lowerIsBetter": false, "filtered": 344.60701600000004, "unit": "score", "value": 344.60701600000004}, "Encrypt": {"lowerIsBetter": false, "filtered": 943.8778259999998, "unit": "score", "value": 943.8778259999998}, "NavierStokes": {"lowerIsBetter": false, "filtered": 307.7487537387835, "unit": "score", "value": 307.7487537387835}, "Decrypt": {"lowerIsBetter": false, "filtered": 52.91710189810189, "unit": "score", "value": 52.91710189810189}, "Splay": {"lowerIsBetter": false, "filtered": 135.92698800000005, "unit": "score", "value": 135.92698800000005}, "RegExp": {"lowerIsBetter": false, "filtered": 36.65395976447495, "unit": "score", "value": 36.65395976447495}, "Richards": {"lowerIsBetter": false, "filtered": 207.85817599999996, "unit": "score", "value": 207.85817599999996}, "Earley": {"lowerIsBetter": false, "filtered": 945.7109970000002, "unit": "score", "value": 945.7109970000002}, "Boyer": {"lowerIsBetter": false, "filtered": 56.536282435129706, "unit": "score", "value": 56.536282435129706}, "RayTrace": {"lowerIsBetter": false, "filtered": 697.809627, "unit": "score", "value": 697.809627}}}, "test_machine": {"platform": "x86_64", "osversion": "Ubuntu 12.04.e", "os": "linux", "name": "talos-linux64-ix-009.e"}, "testrun": {"date": 1447264341, "suite": "v8_7", "options": {"responsiveness": false, "tpmozafterpaint": false, "tpchrome": true, "tppagecycles": 1, "tpcycles": 1, "tprender": false, "shutdown": false, "cycles": 1, "rss": false}}, "test_build": {"name": "Firefox", "version": "45.0a1", "id": "20151111083010", "branch": "Fx-Team", "revision": "e402ff476e1b9ff5764aeec44442ab3213c2efc6"}}] 10:12:32 INFO - RETURN: dromaeo_css: 6956.36 10:12:32 INFO - RETURN: kraken: 1509.70 10:12:32 INFO - RETURN: v8_7: 21517.03 10:12:32 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,64,43]]", "result": "21517.03"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,43]]", "result": "1509.70"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,43]]", "result": "6956.36"}}} 10:12:32 INFO - Return code: 0 10:12:32 INFO - # TBPL SUCCESS # 10:12:32 INFO - Running post-action listener: _resource_record_post_action 10:12:32 INFO - Running post-run listener: _resource_record_post_run 10:12:33 INFO - Total resource usage - Wall time: 1225s; CPU: 13.0%; Read bytes: 4096; Write bytes: 527380480; Read time: 264; Write time: 524088 10:12:33 INFO - install - Wall time: 15s; CPU: 13.0%; Read bytes: 0; Write bytes: 80007168; Read time: 0; Write time: 36488 10:12:33 INFO - run-tests - Wall time: 1211s; CPU: 13.0%; Read bytes: 4096; Write bytes: 367030272; Read time: 264; Write time: 355588 10:12:33 INFO - Running post-run listener: _upload_blobber_files 10:12:33 INFO - Blob upload gear active. 10:12:33 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 10:12:33 INFO - Copying logs to upload dir... 10:12:33 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1257.532810 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 57 secs) (at 2015-11-11 10:12:33.981912) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-11 10:12:33.985265) ========= bash -c 'for file in `ls -1`; do cat $file; done' in dir /builds/slave/test-pgo/properties (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'for file in `ls -1`; do cat $file; done'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test-pgo/properties SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=a732b360c9c0c9a4a8cfc42c000001d9-1447263937.475703-2145690893 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/sOPdHRtjTQGttforyY7Bhg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.009179 build_url: 'https://queue.taskcluster.net/v1/task/sOPdHRtjTQGttforyY7Bhg/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-11 10:12:34.035125) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-11 10:12:34.035438) ========= rm -f oauth.txt in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-f', 'oauth.txt'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=a732b360c9c0c9a4a8cfc42c000001d9-1447263937.475703-2145690893 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004560 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-11 10:12:34.084762) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-11 10:12:34.085076) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-11 10:12:34.085356) ========= ========= Total master_lag: 0.23 =========