builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-045 starttime: 1448363917.86 results: success (0) buildid: 20151124023016 builduid: 934c9b56ca1f4766b7f03db7cab566b6 revision: 9d1be94ff95a2252405ae5ec6fb4a8d083440dbe ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-11-24 03:18:37.863344) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-11-24 03:18:37.863800) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-24 03:18:37.864116) ========= 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=61fa6ed41387771909ec0f71000001b3-1448361288.653835-2030861842 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006601 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.03 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-24 03:18:37.899454) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-24 03:18:37.899768) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-24 03:18:37.920485) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-24 03:18:37.920901) ========= 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=61fa6ed41387771909ec0f71000001b3-1448361288.653835-2030861842 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004569 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-24 03:18:37.969469) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-24 03:18:37.969771) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-24 03:18:37.970147) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-24 03:18:37.970422) ========= 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=61fa6ed41387771909ec0f71000001b3-1448361288.653835-2030861842 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-11-24 03:18:38-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 220M=0s 2015-11-24 03:18:38 (220 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.193329 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-24 03:18:38.175303) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-24 03:18:38.175572) ========= 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=61fa6ed41387771909ec0f71000001b3-1448361288.653835-2030861842 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014671 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-24 03:18:38.224889) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-24 03:18:38.225260) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 9d1be94ff95a2252405ae5ec6fb4a8d083440dbe --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 9d1be94ff95a2252405ae5ec6fb4a8d083440dbe --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=61fa6ed41387771909ec0f71000001b3-1448361288.653835-2030861842 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-11-24 03:18:38,391 truncating revision to first 12 chars 2015-11-24 03:18:38,391 Setting DEBUG logging. 2015-11-24 03:18:38,391 attempt 1/10 2015-11-24 03:18:38,391 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/9d1be94ff95a?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-11-24 03:18:38,646 unpacking tar archive at: fx-team-9d1be94ff95a/testing/mozharness/ program finished with exit code 0 elapsedTime=0.551070 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-24 03:18:38.790109) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-24 03:18:38.790449) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-24 03:18:38.797411) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-24 03:18:38.797666) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-24 03:18:38.798065) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 22 mins, 24 secs) (at 2015-11-24 03:18:38.798352) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --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', '--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=61fa6ed41387771909ec0f71000001b3-1448361288.653835-2030861842 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 03:18:39 INFO - MultiFileLogger online at 20151124 03:18:39 in /builds/slave/test-pgo 03:18:39 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --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 03:18:39 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 03:18:39 INFO - {'append_to_log': False, 03:18:39 INFO - 'base_work_dir': '/builds/slave/test-pgo', 03:18:39 INFO - 'blob_upload_branch': 'Fx-Team', 03:18:39 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 03:18:39 INFO - 'branch': 'Fx-Team', 03:18:39 INFO - 'buildbot_json_path': 'buildprops.json', 03:18:39 INFO - 'config_files': ('talos/linux_config.py',), 03:18:39 INFO - 'default_actions': ('clobber', 03:18:39 INFO - 'read-buildbot-config', 03:18:39 INFO - 'download-and-extract', 03:18:39 INFO - 'populate-webroot', 03:18:39 INFO - 'create-virtualenv', 03:18:39 INFO - 'install', 03:18:39 INFO - 'run-tests'), 03:18:39 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:18:39 INFO - 'download_minidump_stackwalk': True, 03:18:39 INFO - 'download_symbols': 'ondemand', 03:18:39 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:18:39 INFO - 'tooltool.py': '/tools/tooltool.py', 03:18:39 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:18:39 INFO - '/tools/misc-python/virtualenv.py')}, 03:18:39 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:18:39 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:18:39 INFO - 'installer_path': 'installer.exe', 03:18:39 INFO - 'log_level': 'info', 03:18:39 INFO - 'log_name': 'talos', 03:18:39 INFO - 'log_to_console': True, 03:18:39 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 03:18:39 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 03:18:39 INFO - 'opt_config_files': (), 03:18:39 INFO - 'pip_index': False, 03:18:39 INFO - 'sps_profile': False, 03:18:39 INFO - 'sps_profile_interval': 0, 03:18:39 INFO - 'suite': 'dromaeojs', 03:18:39 INFO - 'system_bits': '64', 03:18:39 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:18:39 INFO - 'title': 'talos-linux64-ix-045', 03:18:39 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:18:39 INFO - 'use_talos_json': True, 03:18:39 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 03:18:39 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:18:39 INFO - 'work_dir': 'build'} 03:18:39 INFO - ##### 03:18:39 INFO - ##### Running clobber step. 03:18:39 INFO - ##### 03:18:39 INFO - Running pre-action listener: _resource_record_pre_action 03:18:39 INFO - Running main action method: clobber 03:18:39 INFO - rmtree: /builds/slave/test-pgo/build 03:18:39 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 03:18:39 INFO - Running post-action listener: _resource_record_post_action 03:18:39 INFO - ##### 03:18:39 INFO - ##### Running read-buildbot-config step. 03:18:39 INFO - ##### 03:18:39 INFO - Running pre-action listener: _resource_record_pre_action 03:18:39 INFO - Running main action method: read_buildbot_config 03:18:39 INFO - Using buildbot properties: 03:18:39 INFO - { 03:18:39 INFO - "properties": { 03:18:39 INFO - "buildnumber": 800, 03:18:39 INFO - "product": "firefox", 03:18:39 INFO - "script_repo_revision": "production", 03:18:39 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 03:18:39 INFO - "repository": "", 03:18:39 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 03:18:39 INFO - "buildid": "20151124023016", 03:18:39 INFO - "slavename": "talos-linux64-ix-045", 03:18:39 INFO - "pgo_build": "True", 03:18:39 INFO - "basedir": "/builds/slave/test-pgo", 03:18:39 INFO - "project": "", 03:18:39 INFO - "platform": "ubuntu64_hw", 03:18:39 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 03:18:39 INFO - "slavebuilddir": "test", 03:18:39 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 03:18:39 INFO - "branch": "fx-team", 03:18:39 INFO - "repo_path": "integration/fx-team", 03:18:39 INFO - "stage_platform": "linux64-pgo", 03:18:39 INFO - "builduid": "934c9b56ca1f4766b7f03db7cab566b6", 03:18:39 INFO - "revision": "9d1be94ff95a2252405ae5ec6fb4a8d083440dbe" 03:18:39 INFO - }, 03:18:39 INFO - "sourcestamp": { 03:18:39 INFO - "repository": "", 03:18:39 INFO - "hasPatch": false, 03:18:39 INFO - "project": "", 03:18:39 INFO - "branch": "fx-team-linux64-pgo-talos", 03:18:39 INFO - "changes": [ 03:18:39 INFO - { 03:18:39 INFO - "category": null, 03:18:39 INFO - "files": [ 03:18:39 INFO - { 03:18:39 INFO - "url": null, 03:18:39 INFO - "name": "https://queue.taskcluster.net/v1/task/E06hassIRkqzMBinPtTc3g/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2" 03:18:39 INFO - } 03:18:39 INFO - ], 03:18:39 INFO - "repository": "", 03:18:39 INFO - "rev": "9d1be94ff95a2252405ae5ec6fb4a8d083440dbe", 03:18:39 INFO - "who": "sendchange", 03:18:39 INFO - "when": 1448363872, 03:18:39 INFO - "number": 6699696, 03:18:39 INFO - "comments": "", 03:18:39 INFO - "project": "", 03:18:39 INFO - "at": "Tue 24 Nov 2015 03:17:52", 03:18:39 INFO - "branch": "fx-team-linux64-pgo-talos", 03:18:39 INFO - "revlink": "", 03:18:39 INFO - "properties": [ 03:18:39 INFO - [ 03:18:39 INFO - "buildid", 03:18:39 INFO - "20151124023016", 03:18:39 INFO - "Change" 03:18:39 INFO - ], 03:18:39 INFO - [ 03:18:39 INFO - "builduid", 03:18:39 INFO - "934c9b56ca1f4766b7f03db7cab566b6", 03:18:39 INFO - "Change" 03:18:39 INFO - ], 03:18:39 INFO - [ 03:18:39 INFO - "pgo_build", 03:18:39 INFO - "True", 03:18:39 INFO - "Change" 03:18:39 INFO - ] 03:18:39 INFO - ], 03:18:39 INFO - "revision": "9d1be94ff95a2252405ae5ec6fb4a8d083440dbe" 03:18:39 INFO - } 03:18:39 INFO - ], 03:18:39 INFO - "revision": "9d1be94ff95a2252405ae5ec6fb4a8d083440dbe" 03:18:39 INFO - } 03:18:39 INFO - } 03:18:39 INFO - Found installer url https://queue.taskcluster.net/v1/task/E06hassIRkqzMBinPtTc3g/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2. 03:18:39 INFO - Running post-action listener: _resource_record_post_action 03:18:39 INFO - ##### 03:18:39 INFO - ##### Running download-and-extract step. 03:18:39 INFO - ##### 03:18:39 INFO - Running pre-action listener: _resource_record_pre_action 03:18:39 INFO - Running main action method: download_and_extract 03:18:39 INFO - mkdir: /builds/slave/test-pgo/build/tests 03:18:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:18:39 INFO - https://queue.taskcluster.net/v1/task/E06hassIRkqzMBinPtTc3g/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 03:18:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E06hassIRkqzMBinPtTc3g/artifacts/public/build/test_packages.json 03:18:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E06hassIRkqzMBinPtTc3g/artifacts/public/build/test_packages.json 03:18:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E06hassIRkqzMBinPtTc3g/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 03:18:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E06hassIRkqzMBinPtTc3g/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 03:18:40 INFO - Downloaded 1302 bytes. 03:18:40 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 03:18:40 INFO - Using the following test package requirements: 03:18:40 INFO - {u'common': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 03:18:40 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 03:18:40 INFO - u'firefox-45.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 03:18:40 INFO - u'jittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 03:18:40 INFO - u'jsshell-linux-x86_64.zip'], 03:18:40 INFO - u'mochitest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 03:18:40 INFO - u'firefox-45.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 03:18:40 INFO - u'mozbase': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 03:18:40 INFO - u'reftest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 03:18:40 INFO - u'firefox-45.0a1.en-US.linux-x86_64.reftest.tests.zip'], 03:18:40 INFO - u'talos': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 03:18:40 INFO - u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'], 03:18:40 INFO - u'web-platform': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 03:18:40 INFO - u'firefox-45.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 03:18:40 INFO - u'webapprt': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 03:18:40 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 03:18:40 INFO - u'firefox-45.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 03:18:40 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 03:18:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:18:40 INFO - https://queue.taskcluster.net/v1/task/E06hassIRkqzMBinPtTc3g/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 03:18:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E06hassIRkqzMBinPtTc3g/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 03:18:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E06hassIRkqzMBinPtTc3g/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 03:18:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E06hassIRkqzMBinPtTc3g/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 03:18:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E06hassIRkqzMBinPtTc3g/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 03:18:41 INFO - Downloaded 22525996 bytes. 03:18: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 03:18:41 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 03:18: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 03:18:42 INFO - Return code: 0 03:18: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 03:18: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')]} 03:18:42 INFO - https://queue.taskcluster.net/v1/task/E06hassIRkqzMBinPtTc3g/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 03:18:42 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E06hassIRkqzMBinPtTc3g/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 03:18:42 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E06hassIRkqzMBinPtTc3g/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 03:18:42 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E06hassIRkqzMBinPtTc3g/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 03:18:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E06hassIRkqzMBinPtTc3g/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 03:18:44 INFO - Downloaded 22525996 bytes. 03:18:44 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 03:18:44 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 03:18:44 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 03:18:45 INFO - Return code: 0 03:18:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:18:45 INFO - https://queue.taskcluster.net/v1/task/E06hassIRkqzMBinPtTc3g/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 03:18:45 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E06hassIRkqzMBinPtTc3g/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 03:18:45 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E06hassIRkqzMBinPtTc3g/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 03:18:45 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E06hassIRkqzMBinPtTc3g/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 03:18:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E06hassIRkqzMBinPtTc3g/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 03:18:46 INFO - Downloaded 11130997 bytes. 03:18:46 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 03:18:46 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 03:18:46 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 03:18:47 INFO - Return code: 0 03:18: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')]} 03:18:47 INFO - https://queue.taskcluster.net/v1/task/E06hassIRkqzMBinPtTc3g/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 03:18:47 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E06hassIRkqzMBinPtTc3g/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 03:18:47 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E06hassIRkqzMBinPtTc3g/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 03:18:47 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E06hassIRkqzMBinPtTc3g/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 03:18:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E06hassIRkqzMBinPtTc3g/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 03:18:48 INFO - Downloaded 57577387 bytes. 03:18:48 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/E06hassIRkqzMBinPtTc3g/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 03:18:48 INFO - mkdir: /builds/slave/test-pgo/properties 03:18:48 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 03:18:48 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 03:18:48 INFO - Contents: 03:18:48 INFO - build_url:https://queue.taskcluster.net/v1/task/E06hassIRkqzMBinPtTc3g/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 03:18:48 INFO - Running post-action listener: _resource_record_post_action 03:18:48 INFO - Running post-action listener: set_extra_try_arguments 03:18:48 INFO - ##### 03:18:48 INFO - ##### Running populate-webroot step. 03:18:48 INFO - ##### 03:18:48 INFO - Running pre-action listener: _resource_record_pre_action 03:18:48 INFO - Running main action method: populate_webroot 03:18:48 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 03:18:48 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 03:18:48 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 03:18:48 INFO - '../fennec_ids.txt'], 03:18:48 INFO - 'tests': ['tcheck2']}, 03:18:48 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 03:18:48 INFO - '--tppagecycles', 03:18:48 INFO - '7'], 03:18:48 INFO - 'tests': ['tsvgm']}}, 03:18:48 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 03:18:48 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 03:18:48 INFO - 'tests': ['tresize', 'tcanvasmark']}, 03:18:48 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 03:18:48 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 03:18:48 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 03:18:48 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:18:48 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:18:48 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:18:48 INFO - 'talos_options': ['--e10s'], 03:18:48 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:18:48 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:18:48 INFO - 'tests': ['damp', 'tps']}, 03:18:48 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:18:48 INFO - 'talos_options': ['--e10s'], 03:18:48 INFO - 'tests': ['damp', 'tps']}, 03:18:48 INFO - 'g3': {'tests': ['dromaeo_dom']}, 03:18:48 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:18:48 INFO - 'other': {'tests': ['a11yr', 03:18:48 INFO - 'ts_paint', 03:18:48 INFO - 'tpaint', 03:18:48 INFO - 'sessionrestore', 03:18:48 INFO - 'sessionrestore_no_auto_restore']}, 03:18:48 INFO - 'other-e10s': {'talos_options': ['--e10s'], 03:18:48 INFO - 'tests': ['a11yr', 03:18:48 INFO - 'ts_paint', 03:18:48 INFO - 'tpaint', 03:18:48 INFO - 'sessionrestore', 03:18:48 INFO - 'sessionrestore_no_auto_restore']}, 03:18:48 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 03:18:48 INFO - 'tests': ['a11yr', 03:18:48 INFO - 'ts_paint', 03:18:48 INFO - 'tpaint', 03:18:48 INFO - 'sessionrestore', 03:18:48 INFO - 'sessionrestore_no_auto_restore']}, 03:18:48 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 03:18:48 INFO - 'tests': ['a11yr', 03:18:48 INFO - 'ts_paint', 03:18:48 INFO - 'tpaint', 03:18:48 INFO - 'sessionrestore', 03:18:48 INFO - 'sessionrestore_no_auto_restore']}, 03:18:48 INFO - 'other_l64': {'tests': ['a11yr', 03:18:48 INFO - 'ts_paint', 03:18:48 INFO - 'tpaint', 03:18:48 INFO - 'sessionrestore', 03:18:48 INFO - 'sessionrestore_no_auto_restore']}, 03:18:48 INFO - 'other_nol64': {'tests': ['a11yr', 03:18:48 INFO - 'ts_paint', 03:18:48 INFO - 'tpaint', 03:18:48 INFO - 'sessionrestore', 03:18:48 INFO - 'sessionrestore_no_auto_restore']}, 03:18:48 INFO - 'svgr': {'tests': ['tsvgx', 03:18:48 INFO - 'tsvgr_opacity', 03:18:48 INFO - 'tart', 03:18:48 INFO - 'tscrollx', 03:18:48 INFO - 'cart']}, 03:18:48 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 03:18:48 INFO - 'tests': ['tsvgx', 03:18:48 INFO - 'tsvgr_opacity', 03:18:48 INFO - 'tart', 03:18:48 INFO - 'tscrollx', 03:18:48 INFO - 'cart']}, 03:18:48 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:18:48 INFO - 'tests': ['tp5o']}, 03:18:48 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:18:48 INFO - 'talos_options': ['--e10s'], 03:18:48 INFO - 'tests': ['tp5o']}, 03:18:48 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:18:48 INFO - 'talos_options': ['--xperf_path', 03:18:48 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:18:48 INFO - 'tests': ['tp5n']}, 03:18:48 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:18:48 INFO - 'talos_options': ['--e10s', 03:18:48 INFO - '--xperf_path', 03:18:48 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:18:48 INFO - 'tests': ['tp5n']}}, 03:18:48 INFO - 'talos.zip': {'path': '', 03:18:48 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 03:18:48 INFO - Running post-action listener: _resource_record_post_action 03:18:48 INFO - ##### 03:18:48 INFO - ##### Running create-virtualenv step. 03:18:48 INFO - ##### 03:18:48 INFO - Running pre-action listener: _resource_record_pre_action 03:18:48 INFO - Running main action method: create_virtualenv 03:18:48 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 03:18:48 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test-pgo/build/venv'] in /builds/slave/test-pgo/build 03:18:48 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 03:18:48 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:18:48 INFO - Using real prefix '/usr' 03:18:48 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 03:18:49 INFO - Installing distribute.............................................................................................................................................................................................done. 03:18:51 INFO - Installing pip.................done. 03:18:51 INFO - Return code: 0 03:18:51 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 03:18:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:18:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:18:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:18:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:18:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:18:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:18: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 0x7f3ca2005c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e16c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11937c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11d7d70>, '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 0x11d8b20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11d8fb0>, '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': '61fa6ed41387771909ec0f71000001b3-1448361288.653835-2030861842', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:18: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 03:18: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 03:18:51 INFO - Using env: {'DISPLAY': ':0', 03:18:51 INFO - 'HOME': '/home/cltbld', 03:18:51 INFO - 'LANG': 'en_US.UTF-8', 03:18:51 INFO - 'LANGUAGE': 'en_US:en', 03:18:51 INFO - 'LOGNAME': 'cltbld', 03:18:51 INFO - 'MAIL': '/var/mail/cltbld', 03:18:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:18:51 INFO - 'MOZ_NO_REMOTE': '1', 03:18:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:18:51 INFO - 'NO_EM_RESTART': '1', 03:18:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:18:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 03:18:51 INFO - 'PWD': '/builds/slave/test-pgo', 03:18:51 INFO - 'SHELL': '/bin/bash', 03:18:51 INFO - 'SHLVL': '1', 03:18:51 INFO - 'TERM': 'linux', 03:18:51 INFO - 'TMOUT': '86400', 03:18:51 INFO - 'USER': 'cltbld', 03:18:51 INFO - 'XDG_SESSION_COOKIE': '61fa6ed41387771909ec0f71000001b3-1448361288.653835-2030861842', 03:18:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:18:51 INFO - '_': '/tools/buildbot/bin/python'} 03:18:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:18: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 03:18:51 INFO - Cleaning up... 03:18:51 INFO - Return code: 0 03:18:51 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 03:18:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:18:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:18:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:18:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:18:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:18:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:18: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 0x7f3ca2005c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e16c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11937c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11d7d70>, '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 0x11d8b20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11d8fb0>, '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': '61fa6ed41387771909ec0f71000001b3-1448361288.653835-2030861842', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:18: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 03:18: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 03:18:51 INFO - Using env: {'DISPLAY': ':0', 03:18:51 INFO - 'HOME': '/home/cltbld', 03:18:51 INFO - 'LANG': 'en_US.UTF-8', 03:18:51 INFO - 'LANGUAGE': 'en_US:en', 03:18:51 INFO - 'LOGNAME': 'cltbld', 03:18:51 INFO - 'MAIL': '/var/mail/cltbld', 03:18:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:18:51 INFO - 'MOZ_NO_REMOTE': '1', 03:18:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:18:51 INFO - 'NO_EM_RESTART': '1', 03:18:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:18:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 03:18:51 INFO - 'PWD': '/builds/slave/test-pgo', 03:18:51 INFO - 'SHELL': '/bin/bash', 03:18:51 INFO - 'SHLVL': '1', 03:18:51 INFO - 'TERM': 'linux', 03:18:51 INFO - 'TMOUT': '86400', 03:18:51 INFO - 'USER': 'cltbld', 03:18:51 INFO - 'XDG_SESSION_COOKIE': '61fa6ed41387771909ec0f71000001b3-1448361288.653835-2030861842', 03:18:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:18:51 INFO - '_': '/tools/buildbot/bin/python'} 03:18:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:18:51 INFO - Downloading/unpacking psutil>=0.7.1 03:18:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:18:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:18:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:18:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:18:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:18:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:18:53 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 03:18:53 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 03:18:53 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 03:18:53 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:18:53 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:18:53 INFO - Installing collected packages: psutil 03:18:53 INFO - Running setup.py install for psutil 03:18:53 INFO - building 'psutil._psutil_linux' extension 03:18:53 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 03:18: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 03:18:54 INFO - building 'psutil._psutil_posix' extension 03:18: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 03:18: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 03:18:54 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:18:54 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:18:54 INFO - Successfully installed psutil 03:18:54 INFO - Cleaning up... 03:18:54 INFO - Return code: 0 03:18:54 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 03:18: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')]} 03:18:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:18:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:18: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')]} 03:18:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:18:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:18: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 0x7f3ca2005c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e16c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11937c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11d7d70>, '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 0x11d8b20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11d8fb0>, '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': '61fa6ed41387771909ec0f71000001b3-1448361288.653835-2030861842', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:18: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 03:18: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 03:18:54 INFO - Using env: {'DISPLAY': ':0', 03:18:54 INFO - 'HOME': '/home/cltbld', 03:18:54 INFO - 'LANG': 'en_US.UTF-8', 03:18:54 INFO - 'LANGUAGE': 'en_US:en', 03:18:54 INFO - 'LOGNAME': 'cltbld', 03:18:54 INFO - 'MAIL': '/var/mail/cltbld', 03:18:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:18:54 INFO - 'MOZ_NO_REMOTE': '1', 03:18:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:18:54 INFO - 'NO_EM_RESTART': '1', 03:18:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:18:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 03:18:54 INFO - 'PWD': '/builds/slave/test-pgo', 03:18:54 INFO - 'SHELL': '/bin/bash', 03:18:54 INFO - 'SHLVL': '1', 03:18:54 INFO - 'TERM': 'linux', 03:18:54 INFO - 'TMOUT': '86400', 03:18:54 INFO - 'USER': 'cltbld', 03:18:54 INFO - 'XDG_SESSION_COOKIE': '61fa6ed41387771909ec0f71000001b3-1448361288.653835-2030861842', 03:18:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:18:54 INFO - '_': '/tools/buildbot/bin/python'} 03:18:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:18:54 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 03:18: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 03:18: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 03:18: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 03:18: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 03:18: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 03:18: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 03:18:56 INFO - Downloading mozsystemmonitor-0.0.tar.gz 03:18:56 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 03:18:56 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:18: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) 03:18:56 INFO - Installing collected packages: mozsystemmonitor 03:18:56 INFO - Running setup.py install for mozsystemmonitor 03:18:56 INFO - Successfully installed mozsystemmonitor 03:18:56 INFO - Cleaning up... 03:18:56 INFO - Return code: 0 03:18:56 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 03:18:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:18:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:18:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:18:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:18:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:18:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:18: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 0x7f3ca2005c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e16c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11937c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11d7d70>, '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 0x11d8b20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11d8fb0>, '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': '61fa6ed41387771909ec0f71000001b3-1448361288.653835-2030861842', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:18: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 03:18: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 03:18:56 INFO - Using env: {'DISPLAY': ':0', 03:18:56 INFO - 'HOME': '/home/cltbld', 03:18:56 INFO - 'LANG': 'en_US.UTF-8', 03:18:56 INFO - 'LANGUAGE': 'en_US:en', 03:18:56 INFO - 'LOGNAME': 'cltbld', 03:18:56 INFO - 'MAIL': '/var/mail/cltbld', 03:18:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:18:56 INFO - 'MOZ_NO_REMOTE': '1', 03:18:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:18:56 INFO - 'NO_EM_RESTART': '1', 03:18:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:18:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 03:18:56 INFO - 'PWD': '/builds/slave/test-pgo', 03:18:56 INFO - 'SHELL': '/bin/bash', 03:18:56 INFO - 'SHLVL': '1', 03:18:56 INFO - 'TERM': 'linux', 03:18:56 INFO - 'TMOUT': '86400', 03:18:56 INFO - 'USER': 'cltbld', 03:18:56 INFO - 'XDG_SESSION_COOKIE': '61fa6ed41387771909ec0f71000001b3-1448361288.653835-2030861842', 03:18:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:18:56 INFO - '_': '/tools/buildbot/bin/python'} 03:18:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:18:56 INFO - Downloading/unpacking blobuploader==1.2.4 03:18: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 03:18: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 03:18: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 03:18: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 03:18: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 03:18: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 03:18:58 INFO - Downloading blobuploader-1.2.4.tar.gz 03:18:58 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 03:18:58 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:18:58 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:18: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 03:18: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 03:18: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 03:18: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 03:18: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 03:18: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 03:18:58 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 03:18:58 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 03:18:58 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:18: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 03:18: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 03:18: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 03:18: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 03:18: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 03:18: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 03:18:58 INFO - Downloading docopt-0.6.1.tar.gz 03:18:58 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 03:18:58 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 03:18:59 INFO - Installing collected packages: blobuploader, requests, docopt 03:18:59 INFO - Running setup.py install for blobuploader 03:18:59 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:18:59 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 03:18:59 INFO - Running setup.py install for requests 03:18:59 INFO - Running setup.py install for docopt 03:18:59 INFO - Successfully installed blobuploader requests docopt 03:18:59 INFO - Cleaning up... 03:18:59 INFO - Return code: 0 03:18:59 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 03:18: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')]} 03:18:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:18:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:18: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')]} 03:18:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:18:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:18: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 0x7f3ca2005c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e16c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11937c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11d7d70>, '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 0x11d8b20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11d8fb0>, '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': '61fa6ed41387771909ec0f71000001b3-1448361288.653835-2030861842', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:18: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 03:18: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 03:18:59 INFO - Using env: {'DISPLAY': ':0', 03:18:59 INFO - 'HOME': '/home/cltbld', 03:18:59 INFO - 'LANG': 'en_US.UTF-8', 03:18:59 INFO - 'LANGUAGE': 'en_US:en', 03:18:59 INFO - 'LOGNAME': 'cltbld', 03:18:59 INFO - 'MAIL': '/var/mail/cltbld', 03:18:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:18:59 INFO - 'MOZ_NO_REMOTE': '1', 03:18:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:18:59 INFO - 'NO_EM_RESTART': '1', 03:18:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:18:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 03:18:59 INFO - 'PWD': '/builds/slave/test-pgo', 03:18:59 INFO - 'SHELL': '/bin/bash', 03:18:59 INFO - 'SHLVL': '1', 03:18:59 INFO - 'TERM': 'linux', 03:18:59 INFO - 'TMOUT': '86400', 03:18:59 INFO - 'USER': 'cltbld', 03:18:59 INFO - 'XDG_SESSION_COOKIE': '61fa6ed41387771909ec0f71000001b3-1448361288.653835-2030861842', 03:18:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:18:59 INFO - '_': '/tools/buildbot/bin/python'} 03:18:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:18:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 03:18:59 INFO - Running setup.py (path:/tmp/pip-Yi1vJp-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 03:18:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 03:18:59 INFO - Running setup.py (path:/tmp/pip-xZaY6T-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 03:18:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 03:18:59 INFO - Running setup.py (path:/tmp/pip-vsFfhc-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 03:19:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 03:19:00 INFO - Running setup.py (path:/tmp/pip-I8svgo-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 03:19:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 03:19:00 INFO - Running setup.py (path:/tmp/pip-TZaXGd-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 03:19:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 03:19:00 INFO - Running setup.py (path:/tmp/pip-lXHGsn-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 03:19:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 03:19:00 INFO - Running setup.py (path:/tmp/pip-kaEoX4-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 03:19:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 03:19:00 INFO - Running setup.py (path:/tmp/pip-ubF15A-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 03:19:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 03:19:00 INFO - Running setup.py (path:/tmp/pip-a1wf_l-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 03:19:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 03:19:00 INFO - Running setup.py (path:/tmp/pip-rb_2yw-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 03:19:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 03:19:00 INFO - Running setup.py (path:/tmp/pip-sRB5e8-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 03:19:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 03:19:00 INFO - Running setup.py (path:/tmp/pip-PL_Vr7-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 03:19:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 03:19:00 INFO - Running setup.py (path:/tmp/pip-3lKbEH-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 03:19:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 03:19:00 INFO - Running setup.py (path:/tmp/pip-m32SmF-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 03:19:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 03:19:00 INFO - Running setup.py (path:/tmp/pip-7IYYAY-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 03:19:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 03:19:00 INFO - Running setup.py (path:/tmp/pip-gzyPVV-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 03:19:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 03:19:00 INFO - Running setup.py (path:/tmp/pip-vkvJ_B-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 03:19:01 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:19:01 INFO - Running setup.py install for manifestparser 03:19:01 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 03:19:01 INFO - Running setup.py install for mozcrash 03:19:01 INFO - Running setup.py install for mozdebug 03:19:01 INFO - Running setup.py install for mozdevice 03:19:01 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 03:19:01 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 03:19:01 INFO - Running setup.py install for mozfile 03:19:01 INFO - Running setup.py install for mozhttpd 03:19:01 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 03:19:01 INFO - Running setup.py install for mozinfo 03:19:01 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 03:19:01 INFO - Running setup.py install for mozInstall 03:19:01 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 03:19:01 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 03:19:01 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 03:19:01 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 03:19:01 INFO - Running setup.py install for mozleak 03:19:01 INFO - Running setup.py install for mozlog 03:19:02 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 03:19:02 INFO - Running setup.py install for moznetwork 03:19:02 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 03:19:02 INFO - Running setup.py install for mozprocess 03:19:02 INFO - Running setup.py install for mozprofile 03:19:02 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 03:19:02 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 03:19:02 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 03:19:02 INFO - Running setup.py install for mozrunner 03:19:02 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 03:19:02 INFO - Running setup.py install for mozscreenshot 03:19:02 INFO - Running setup.py install for moztest 03:19:02 INFO - Running setup.py install for mozversion 03:19:02 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 03:19:02 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:19:02 INFO - Cleaning up... 03:19:02 INFO - Return code: 0 03:19:02 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 03:19:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:19:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:19:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:19:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:19:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:19:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:19:02 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-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 0x7f3ca2005c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e16c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11937c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11d7d70>, '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 0x11d8b20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11d8fb0>, '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': '61fa6ed41387771909ec0f71000001b3-1448361288.653835-2030861842', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:19:02 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/config 03:19:02 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 03:19:02 INFO - Using env: {'DISPLAY': ':0', 03:19:02 INFO - 'HOME': '/home/cltbld', 03:19:02 INFO - 'LANG': 'en_US.UTF-8', 03:19:02 INFO - 'LANGUAGE': 'en_US:en', 03:19:02 INFO - 'LOGNAME': 'cltbld', 03:19:02 INFO - 'MAIL': '/var/mail/cltbld', 03:19:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:19:02 INFO - 'MOZ_NO_REMOTE': '1', 03:19:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:19:02 INFO - 'NO_EM_RESTART': '1', 03:19:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:19:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 03:19:02 INFO - 'PWD': '/builds/slave/test-pgo', 03:19:02 INFO - 'SHELL': '/bin/bash', 03:19:02 INFO - 'SHLVL': '1', 03:19:02 INFO - 'TERM': 'linux', 03:19:02 INFO - 'TMOUT': '86400', 03:19:02 INFO - 'USER': 'cltbld', 03:19:02 INFO - 'XDG_SESSION_COOKIE': '61fa6ed41387771909ec0f71000001b3-1448361288.653835-2030861842', 03:19:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:19:02 INFO - '_': '/tools/buildbot/bin/python'} 03:19:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:19:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 03:19:03 INFO - Running setup.py (path:/tmp/pip-1rifJP-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 03:19: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)) 03:19:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 03:19:03 INFO - Running setup.py (path:/tmp/pip-7y2K9x-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 03:19: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)) 03:19:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 03:19:03 INFO - Running setup.py (path:/tmp/pip-IXXBRk-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 03:19: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)) 03:19:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 03:19:03 INFO - Running setup.py (path:/tmp/pip-ELWzH2-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 03:19: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)) 03:19:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 03:19:03 INFO - Running setup.py (path:/tmp/pip-AAHxL4-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 03:19: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)) 03:19:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 03:19:03 INFO - Running setup.py (path:/tmp/pip-TqoGRj-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 03:19: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)) 03:19:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 03:19:03 INFO - Running setup.py (path:/tmp/pip-FmYvfz-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 03:19: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)) 03:19:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 03:19:03 INFO - Running setup.py (path:/tmp/pip-AuwQ87-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 03:19: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)) 03:19:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 03:19:03 INFO - Running setup.py (path:/tmp/pip-CoiBKj-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 03:19: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)) 03:19:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 03:19:03 INFO - Running setup.py (path:/tmp/pip-Jqr7hZ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 03:19:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 03:19:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 03:19:03 INFO - Running setup.py (path:/tmp/pip-2DMSZk-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 03:19:03 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 11)) 03:19:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 03:19:03 INFO - Running setup.py (path:/tmp/pip-vzZl1o-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 03:19:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 12)) 03:19:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 03:19:03 INFO - Running setup.py (path:/tmp/pip-E_2GNE-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 03:19:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.27 from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 13)) 03:19:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 03:19:03 INFO - Running setup.py (path:/tmp/pip-R4EdX7-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 03:19: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)) 03:19:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 03:19:04 INFO - Running setup.py (path:/tmp/pip-Hss4GW-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 03:19: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)) 03:19:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 03:19:04 INFO - Running setup.py (path:/tmp/pip-N9nCg4-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 03:19: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)) 03:19:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 03:19:04 INFO - Running setup.py (path:/tmp/pip-LExaE4-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 03:19: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)) 03:19: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)) 03:19: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)) 03:19: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)) 03:19: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)) 03:19: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)) 03:19:04 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 03:19: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 03:19: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 03:19: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 03:19: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 03:19: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 03:19: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 03:19:08 INFO - Downloading blessings-1.5.1.tar.gz 03:19:08 INFO - Storing download in cache at /builds/slave/test-pgo/build/venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblessings-1.5.1.tar.gz 03:19:08 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 03:19:09 INFO - Installing collected packages: blessings 03:19:09 INFO - Running setup.py install for blessings 03:19:09 INFO - Successfully installed blessings 03:19:09 INFO - Cleaning up... 03:19:09 INFO - Return code: 0 03:19:09 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 03:19:09 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 03:19:09 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 03:19:09 INFO - Reading from file tmpfile_stdout 03:19:09 INFO - Current package versions: 03:19:09 INFO - argparse == 1.2.1 03:19:09 INFO - blessings == 1.5.1 03:19:09 INFO - blobuploader == 1.2.4 03:19:09 INFO - docopt == 0.6.1 03:19:09 INFO - manifestparser == 1.1 03:19:09 INFO - mozInstall == 1.12 03:19:09 INFO - mozcrash == 0.16 03:19:09 INFO - mozdebug == 0.1 03:19:09 INFO - mozdevice == 0.47 03:19:09 INFO - mozfile == 1.2 03:19:09 INFO - mozhttpd == 0.7 03:19:09 INFO - mozinfo == 0.9 03:19:09 INFO - mozleak == 0.1 03:19:09 INFO - mozlog == 3.1 03:19:09 INFO - moznetwork == 0.27 03:19:09 INFO - mozprocess == 0.22 03:19:09 INFO - mozprofile == 0.27 03:19:09 INFO - mozrunner == 6.11 03:19:09 INFO - mozscreenshot == 0.1 03:19:09 INFO - mozsystemmonitor == 0.0 03:19:09 INFO - moztest == 0.7 03:19:09 INFO - mozversion == 1.4 03:19:09 INFO - psutil == 3.1.1 03:19:09 INFO - requests == 1.2.3 03:19:09 INFO - wsgiref == 0.1.2 03:19:09 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 03:19:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:19:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:19:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:19:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:19:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:19:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:19:09 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f3ca2005c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e16c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11937c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11d7d70>, '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 0x11d8b20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11d8fb0>, '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': '61fa6ed41387771909ec0f71000001b3-1448361288.653835-2030861842', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:19:09 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/talos 03:19:09 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 -r /builds/slave/test-pgo/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 03:19:09 INFO - Using env: {'DISPLAY': ':0', 03:19:09 INFO - 'HOME': '/home/cltbld', 03:19:09 INFO - 'LANG': 'en_US.UTF-8', 03:19:09 INFO - 'LANGUAGE': 'en_US:en', 03:19:09 INFO - 'LOGNAME': 'cltbld', 03:19:09 INFO - 'MAIL': '/var/mail/cltbld', 03:19:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:19:09 INFO - 'MOZ_NO_REMOTE': '1', 03:19:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:19:09 INFO - 'NO_EM_RESTART': '1', 03:19:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:19:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 03:19:09 INFO - 'PWD': '/builds/slave/test-pgo', 03:19:09 INFO - 'SHELL': '/bin/bash', 03:19:09 INFO - 'SHLVL': '1', 03:19:09 INFO - 'TERM': 'linux', 03:19:09 INFO - 'TMOUT': '86400', 03:19:09 INFO - 'USER': 'cltbld', 03:19:09 INFO - 'XDG_SESSION_COOKIE': '61fa6ed41387771909ec0f71000001b3-1448361288.653835-2030861842', 03:19:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:19:09 INFO - '_': '/tools/buildbot/bin/python'} 03:19:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:19:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 03:19:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 2)) 03:19:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 3)) 03:19:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 4)) 03:19:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 5)) 03:19:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 6)) 03:19:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 7)) 03:19:09 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 8)) 03:19:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash>=0.15->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 03:19:09 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 3)) 03:19:09 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozlog>=3.0->mozcrash>=0.15->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 03:19:09 INFO - Cleaning up... 03:19:09 INFO - Return code: 0 03:19:09 INFO - Running post-action listener: _resource_record_post_action 03:19:09 INFO - Running post-action listener: _start_resource_monitoring 03:19:09 INFO - Starting resource monitoring. 03:19:09 INFO - ##### 03:19:09 INFO - ##### Running install step. 03:19:09 INFO - ##### 03:19:09 INFO - Running pre-action listener: _resource_record_pre_action 03:19:09 INFO - Running main action method: install 03:19:09 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 03:19:09 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 03:19:09 INFO - Reading from file tmpfile_stdout 03:19:09 INFO - Detecting whether we're running mozinstall >=1.0... 03:19:09 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 03:19:09 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 03:19:09 INFO - Reading from file tmpfile_stdout 03:19:09 INFO - Output received: 03:19:09 INFO - Usage: mozinstall [options] installer 03:19:09 INFO - Options: 03:19:09 INFO - -h, --help show this help message and exit 03:19:09 INFO - -d DEST, --destination=DEST 03:19:09 INFO - Directory to install application into. [default: 03:19:09 INFO - "/builds/slave/test-pgo"] 03:19:09 INFO - --app=APP Application being installed. [default: firefox] 03:19:09 INFO - mkdir: /builds/slave/test-pgo/build/application 03:19:09 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'] 03:19:09 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 03:19:24 INFO - Reading from file tmpfile_stdout 03:19:24 INFO - Output received: 03:19:24 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 03:19:24 INFO - Running post-action listener: _resource_record_post_action 03:19:24 INFO - ##### 03:19:24 INFO - ##### Running run-tests step. 03:19:24 INFO - ##### 03:19:24 INFO - Running pre-action listener: _resource_record_pre_action 03:19:24 INFO - Running main action method: run_tests 03:19:24 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 03:19:24 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 03:19:24 INFO - Python 2.7.3 03:19:24 INFO - Return code: 0 03:19:24 INFO - grabbing minidump binary from tooltool 03:19:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:19:24 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 0x11d7d70>, '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 0x11d8b20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11d8fb0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 03:19:24 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test-pgo/build 03:19:24 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 03:19:24 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:19:24 INFO - Return code: 0 03:19:24 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 03:19:24 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 03:19:24 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 03:19:24 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 03:19:24 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 03:19:24 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', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/E06hassIRkqzMBinPtTc3g/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-045', '--webServer', 'localhost'] in /builds/slave/test-pgo/build 03:19:24 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 --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/E06hassIRkqzMBinPtTc3g/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-045 --webServer localhost 03:19:24 INFO - Using env: {'DISPLAY': ':0', 03:19:24 INFO - 'HOME': '/home/cltbld', 03:19:24 INFO - 'LANG': 'en_US.UTF-8', 03:19:24 INFO - 'LANGUAGE': 'en_US:en', 03:19:24 INFO - 'LOGNAME': 'cltbld', 03:19:24 INFO - 'MAIL': '/var/mail/cltbld', 03:19:24 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 03:19:24 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 03:19:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:19:24 INFO - 'MOZ_NO_REMOTE': '1', 03:19:24 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 03:19:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:19:24 INFO - 'NO_EM_RESTART': '1', 03:19:24 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:19:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 03:19:24 INFO - 'PWD': '/builds/slave/test-pgo', 03:19:24 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 03:19:24 INFO - 'SHELL': '/bin/bash', 03:19:24 INFO - 'SHLVL': '1', 03:19:24 INFO - 'TERM': 'linux', 03:19:24 INFO - 'TMOUT': '86400', 03:19:24 INFO - 'USER': 'cltbld', 03:19:24 INFO - 'XDG_SESSION_COOKIE': '61fa6ed41387771909ec0f71000001b3-1448361288.653835-2030861842', 03:19:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:19:24 INFO - '_': '/tools/buildbot/bin/python'} 03:19:24 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', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/E06hassIRkqzMBinPtTc3g/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-045', '--webServer', 'localhost'] with output_timeout 3600 03:19:25 INFO - mozversion INFO | application_buildid: 20151124023016 03:19:25 INFO - mozversion INFO | application_changeset: 9d1be94ff95a2252405ae5ec6fb4a8d083440dbe 03:19:25 INFO - mozversion INFO | application_display_name: Nightly 03:19:25 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:19:25 INFO - mozversion INFO | application_name: Firefox 03:19:25 INFO - mozversion INFO | application_remotingname: firefox 03:19:25 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/fx-team 03:19:25 INFO - mozversion INFO | application_vendor: Mozilla 03:19:25 INFO - mozversion INFO | application_version: 45.0a1 03:19:25 INFO - mozversion INFO | platform_buildid: 20151124023016 03:19:25 INFO - mozversion INFO | platform_changeset: 9d1be94ff95a2252405ae5ec6fb4a8d083440dbe 03:19:25 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/fx-team 03:19:25 INFO - mozversion INFO | platform_version: 45.0a1 03:19:25 INFO - 2015-11-24 03:19:25,178 DEBUG : using testdate: 1448363965 03:19:25 INFO - 2015-11-24 03:19:25,178 DEBUG : actual date: 1448363965 03:19:25 INFO - 2015-11-24 03:19:25,187 INFO : starting webserver on 'localhost:43003' 03:19:25 INFO - 2015-11-24 03:19:25,188 INFO : Starting test suite talos-linux64-ix-045 03:19:25 INFO - 2015-11-24 03:19:25,188 INFO : Starting test dromaeo_css 03:19:25 INFO - 2015-11-24 03:19:25,188 DEBUG : operating with platform_type : linux_ 03:19:25 INFO - 2015-11-24 03:19:25,189 INFO : Initialising browser for dromaeo_css test... 03:19:25 INFO - 2015-11-24 03:19:25,205 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpH0Ru9W/profile http://localhost:43003/getInfo.html 03:19:28 INFO - 2015-11-24 03:19:28,977 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 03:19:28 INFO - 2015-11-24 03:19:28,977 DEBUG : BROWSER_OUTPUT: colorDepth:24 03:19:28 INFO - 2015-11-24 03:19:28,977 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 03:19:28 INFO - 2015-11-24 03:19:28,977 DEBUG : BROWSER_OUTPUT: __metrics 03:19:29 INFO - 2015-11-24 03:19:29,119 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 03:19:30 INFO - 2015-11-24 03:19:30,274 INFO : Browser initialized. 03:19:30 INFO - 2015-11-24 03:19:30,274 INFO : Running cycle 1/1 for dromaeo_css test... 03:19:30 INFO - 2015-11-24 03:19:30,274 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpH0Ru9W/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 03:19:42 INFO - 2015-11-24 03:19:42,090 DEBUG : BROWSER_OUTPUT: RSS: Main: 140066816 03:19:42 INFO - 2015-11-24 03:19:42,090 DEBUG : BROWSER_OUTPUT: 03:20:32 INFO - 2015-11-24 03:20:32,741 DEBUG : BROWSER_OUTPUT: 1448364032739 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] 03:22:42 INFO - 2015-11-24 03:22:42,216 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43003/tests/dromaeo/cssquery-dojo.html (next: http://localhost:43003/tests/dromaeo/cssquery-ext.html) 03:22:44 INFO - 2015-11-24 03:22:44,227 DEBUG : BROWSER_OUTPUT: RSS: Main: 340336640 03:22:44 INFO - 2015-11-24 03:22:44,227 DEBUG : BROWSER_OUTPUT: 03:25:46 INFO - 2015-11-24 03:25:46,829 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43003/tests/dromaeo/cssquery-ext.html (next: http://localhost:43003/tests/dromaeo/cssquery-jquery.html) 03:25:47 INFO - 2015-11-24 03:25:47,395 DEBUG : BROWSER_OUTPUT: RSS: Main: 224407552 03:25:47 INFO - 2015-11-24 03:25:47,395 DEBUG : BROWSER_OUTPUT: 03:28:49 INFO - 2015-11-24 03:28:49,373 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43003/tests/dromaeo/cssquery-jquery.html (next: http://localhost:43003/tests/dromaeo/cssquery-mootools.html) 03:28:49 INFO - 2015-11-24 03:28:49,955 DEBUG : BROWSER_OUTPUT: RSS: Main: 222625792 03:28:49 INFO - 2015-11-24 03:28:49,955 DEBUG : BROWSER_OUTPUT: 03:31:51 INFO - 2015-11-24 03:31:51,895 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43003/tests/dromaeo/cssquery-mootools.html (next: http://localhost:43003/tests/dromaeo/cssquery-prototype.html) 03:31:52 INFO - 2015-11-24 03:31:52,456 DEBUG : BROWSER_OUTPUT: RSS: Main: 200900608 03:31:52 INFO - 2015-11-24 03:31:52,456 DEBUG : BROWSER_OUTPUT: 03:34:55 INFO - 2015-11-24 03:34:55,011 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43003/tests/dromaeo/cssquery-prototype.html (next: http://localhost:43003/tests/dromaeo/cssquery-yui.html) 03:34:55 INFO - 2015-11-24 03:34:55,592 DEBUG : BROWSER_OUTPUT: RSS: Main: 206209024 03:34:55 INFO - 2015-11-24 03:34:55,592 DEBUG : BROWSER_OUTPUT: 03:37:58 INFO - 2015-11-24 03:37:58,141 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43003/tests/dromaeo/cssquery-yui.html (next: http://localhost:43003/tests/dromaeo/cssquery-dojo.html) 03:37:58 INFO - 2015-11-24 03:37:58,391 DEBUG : BROWSER_OUTPUT: RSS: Main: 415465472 03:37:58 INFO - 2015-11-24 03:37:58,391 DEBUG : BROWSER_OUTPUT: 03:37:58 INFO - 2015-11-24 03:37:58,391 DEBUG : BROWSER_OUTPUT: __start_tp_report 03:37:58 INFO - 2015-11-24 03:37:58,392 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 03:37:58 INFO - 2015-11-24 03:37:58,392 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 03:37:58 INFO - 2015-11-24 03:37:58,392 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 03:37:58 INFO - 2015-11-24 03:37:58,395 DEBUG : BROWSER_OUTPUT: |0;dojo.html;3199.6800319967997;3291.6050073991123;3324.401607710611;3324.700776930077;3340.532325474434;5281.339832520935;5377.327834020747;5452.67283962962;5490.780368785248;5542.057850165472;5420.214068959998;5426.375966763823;5479.753411096501;5479.972600136994;5546.889062218764;5005.5244751748705;5012.9749351253195;5025.1708468102715;5037.672551284173;5093.898122037557;4895.926561101586;5030.270610761438;5050.747462626872;5107.923381149286;5140.434552199255;4899.632527560448;5017.473165317644;5023.497650234947;5025.623078269145;5054.267131265982;4988.326575912278;4990.65065445419;4991.151504244287;4994.200927851526;5039.244113382985;4840.636952228597;4970.82602108928;4975.179095449246;4985.1774457214515;5036.294918711384;5174.6636468629795;5184.455632158644;5257.658252213594;5274.973625131888;5303.310569625924;5985.4912332451795;6008.639481631116;6011.909821352683;6017.217761690996;6020.939790602126;5587.469190426903;5706.971465142689;6010.218671572711;6020.638761674313;6030.276366836008;5417.024935511607;5480.945190548123;5519;5527.723613819293;5540.584456165723;5902.966980778347;5906.763729450774;5920.111983202554;5923.407659234128;5937.228160339215;5682.914756278659;5727.942720572824;5754.309482862083;5756.827295181151;5822.214001109796;5764.510016648548;5822.301323841166;5866.325372582122;5911.586188966731;5965.254343207099;5806.21616081832;5875.676837773964;5889.705514724246;5893.970530147321;5896.115582662549;5660.462256085665;5867.61860479076;5880.705964701748;5895.233619629421;5903;4499.437570303712;4534.183846907522;4547.204239258117;4550.47669518003;4578.153041687232;4065.6340929316502;4084.326086195804;4088.202800453883;4090.3864420337186;4128.91742165161;5333.200019997032;5651.491365777099;5664.830055098354;5667.518260947865;5670.206171136044;5729.512991395694;5776.133579962955;5817.592768506249;5861.20873682056;5886.087656413263;5595.804146854841;5674.1488776683;5681.375048744635;5687.914681279784;5688.857778555569;4979.701217926863;5190.896182076337;5202.947970520322;5213;5262.263283140287;6028.095785632103;6050.273967123885;6117.583823141572;6125.384584648569;6126.088324766622;5886.6173698709445;5970.820875373745;5973.223480947623;5975.940240597538;5978.252718410199;5772.393898640582;5885.470307672159;6143.6928153593035;6158.168647232566;6166.876662466815;5780.624259423124;5789.8552536186935;5880.617759845596;5882.735276912635;5934.881302374015;5893.381194974466;5915.852103697442;5916.822495325147;5919.348871624032;5924.674142922181;5628.662280263197;5742.397048309867;5791.710414479175;5792.073268277056;5805.82582522525;5656.490915817596;5691.686957217227;5715.485606295453;5716.571257155647;5718.742656580381;5568.665880047048;5569.387367389503;5570.997220500349;5574.693391863487;5574.9721251393485;5627.606067575394;5671.149327600893;5707.543396528351;5736.196932429547;5816.621919575214;5714.514266287412;5720.199172115824;5723.055695810144;5723.198752174616;5764.365919748908 03:37:58 INFO - 2015-11-24 03:37:58,397 DEBUG : BROWSER_OUTPUT: |1;ext.html;537.0982101591349;596.7135774828082;596.9403059694031;599.5623195067603;602.861341891365;30807.22981925453;32080.03759887201;40361.39457908134;40863.182736345254;40887.79556102223;42762.786186069025;43167.136657266834;43228.13543729123;43325.783371083104;43330;7756.224377562255;8774.254188393994;8926.598303076376;8936.240419564345;8949.149830766068;7742.187070357616;7837.960810195941;10523.789524209511;10795.78408431831;10797.244192906499;10474.58101675932;10557.524911379007;10565.260431769779;10567.78864422711;10577.73555661107;7857.371410287164;8037.316828069621;10361.585536578528;10361.740956476111;10427;7731.845363092707;7839.608019599054;7842.176571460029;10563.894361056446;10871.891281087246;39151.216975660325;39425.802870985746;39626.60373396258;39628.40557391642;39631.603683963076;3300.752443566742;3331.2338162222823;3364.310316385135;3637.254362855608;4050.210209009215;29619.851900740574;29689.851550742107;29842.40315193706;30361.69638303611;30895.227619309473;3791.374423220165;3919.6668283195963;3964.861229856941;4030.2745505808944;4130.3937820748115;260598;262447.6877615619;262540;262717;262868;57481.425185747605;57670.7116464415;57914.420855791745;57929.4207057924;58054;54001.72999134979;55620.27227685692;61973;62240;62247.688761556805;13923.930380348034;14323.85676143246;14327.641808954859;16404.835951640332;16806.32774689023;11377;11459.19785614999;11537;11545.942270288762;11569.88430115705;16462.588435288973;19428.125734341706;19452.416427507196;19551.804481954998;19594.227732586824;6637.3030831762935;7552.8867066994035;7658.157602663702;7668.271514206142;7694.769156925301;949.4777872170279;965.3435663748718;976.3848775271533;1029.3052189771875;1130.5251794246435;26460;27308;27539;27591.86204068967;27821.860890695418;1000.2648053680539;1011.1051719228535;1016.065219997604;1091.6888686724403;1127.9548818047185;14404.423823047171;14528.782068268985;14613.196274204809;14696.412143514353;14833.92583037078;289582;292136;292361;292593;293492;52599.737001315516;52692.473075269525;53103;53192;53220.73389633027;1302.811092391617;1354.2348573056388;1374.3265799758046;1377.366411450744;1383.5088543567292;26589.33526661849;26815.865920670272;27418.115790209165;27676.861615691792;27745.722542774314;43708.34437483504;44317;44830.77584612056;45419.772901135286;45517.54482455133;279980;285931;286877;287357;288039;30145.698543015165;30604.84697576498;30610.387792244477;30617.23456913595;30661;39341.40987885241;40334.19331613293;40777.796111019255;41274.38088428616;41417.58582414258;36092;36841;36965.44551831671;37018.444723328634;40213.39679904862;35269.47095793514;35999;36062.557497699796;36506.452403214505;36582.26835463222;35339.46990795089;36365.0908727284;36741.63258367489;36754.8162259187;36760.81619591992;30944;31748.68251317457;33063.669363307024;33482.66517334795;33550.66449335475;25309.240722778348;25505.48989020246;25717;25746.613800792627;25867.741322587288 03:37:58 INFO - 2015-11-24 03:37:58,398 DEBUG : BROWSER_OUTPUT: |2;jquery.html;351.17649112830406;353.0995960301232;354.50723494342867;355.58041511017024;359.84706499737604;14272.215028173447;14764.04033737809;15983.76024359634;16488.91755541222;17199.226034828433;16354.754678679828;16972.915135424304;16987.74518382225;17470.039147846863;17499.475015749515;5261.921071183926;5427.402985671573;5427.891442171154;5430;5431.701256430894;4111.36273877548;4260.0414906646065;5405.216243644669;5947.791827286046;6108.969455152718;5884.941150588504;5998.52011839054;6015.669138197398;6046.606970546923;6047.304559975593;6088.056351265561;6093.939060609404;6149.169862068608;6164.630122192638;6169.321374648785;5232.686038837682;5315.734213289359;5352.464753524655;5366.8926621467745;5371.301730775013;21343.35969920905;21537.246196383207;21715.674264886038;21783.34649960504;21971.34085977423;2203.5262418579923;2213.9889300553555;2281.3042022183226;2321.4776675248104;2345.5660702769874;13391.464341426332;13570.185788852601;13631.863681363258;13990.650233744136;14172.787408188886;1764.1003088424868;1837.3844762004744;1856.693645548483;1869.3457289948544;1893.5266183454137;59988.700056499874;63069.369306306806;63637.68181159064;64333.3566664332;65665.01502477466;9466.432014079177;9522.047795220422;9717.854232186522;10074.244431667654;10117.342372745896;13032.934835325763;13113.737725245443;13208.141470804367;13248.933755331162;13250.072494925264;7558.281963213486;7612.1246056703085;7616.857471379338;7682.193369696213;7695.268949449794;7327.047483827068;7386.519876208029;7386.556806591621;7453.2546745325035;7456.627168641547;5579.2746942897165;6024.0662697282;6092.908606370908;6115.205023347025;6126.632402055891;1662.7339625659836;1729.5676080979756;1750.1249375312343;1768.849647779953;1778.199810085441;388.92610404023145;399.2354640862773;399.9580044095328;411.8187997281187;1002.3134153105146;10412.947935260276;10550.261481696361;10950.178736594627;11049.944750276198;11069.5018724156;431.7733190075236;431.8920269932517;435.18185810675726;458.9311603259538;467.483430808958;9736.805263894825;9920.454375009444;10142.746431339128;10249.590016399261;10374.740631484274;471087;476219;501952;532236;532448;80243;81827.59086204531;81854.59072704599;82314.58842705868;82535;1142.6973250494443;1155.838182654446;1161.9070474362031;1165.4988355007258;1165.516310731037;12889.548865789653;15248;15370.154641494824;15843.920780396023;15857.682846342777;33523.329533409684;33634.32731345409;33822;34434.82782586071;34562.654373455945;49807;50985.23522147245;51800.222996654324;52449;52641.47358526366;9429.952850235704;9603.951980240054;9627.326087173831;9727;9752.756181095529;11306.83039754388;11340;11352.489137988976;11406.315621062762;12911.741765164832;14855.92572037133;14885.851141488447;15112.773308400603;15205.391784328503;15231.77484158542;13892.513762018281;14407;14471.927640361731;14808.851911480748;15109.244537772847;14545.41818327255;14796.704065918406;14910.105393676415;15180.544583662508;15258.160801156044;9049.457032578066;9133.132352426508;9299.209567186594;9477.431354118775;9502.47736374506;9579.760505987128;10387.532561034923;14497.565073047825;15155.848441515443;15287 03:37:58 INFO - 2015-11-24 03:37:58,399 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1325.337331334333;1457.1184433417782;1479.58571599952;1634.9346026158955;1783.3223375117445;6511.576747511414;7668.309852113309;7847.489913155641;7852.136265010844;7853;7635.541867487955;7776.650050747716;7782.805429864256;7783.571903545303;7797.6491057902385;1936.6707659697815;1965.0174912543728;1966.9409917702492;2216.1910902520544;2238.563480121377;2213.7122174117344;2240.047979608668;2244.1360076370634;2245.404967683557;2245.5059886824874;2179.705739725133;2202.2622421488823;2208.0615738311153;2241.8430709850318;2247.898844551999;1952.7363805886237;1987.4435158155595;2128.9254876079262;2199.7800219977953;2229.308914236584;2225.6661500775012;2235.1841577823975;2235.798778109978;2236.2955668964223;2238.6082435573708;7573.356264717506;7591.620418979029;7591.962040189764;7625.923740762577;7628.122765881939;4591.954080459186;4644.512326205768;4658.95341046592;4660.184467718136;4687.343771871941;2948.9262768430963;2967.406518696248;3036.7266945974748;3055.724984751361;3068.3709839482854;959.4147569982305;962.9374090684153;997.3417544420647;1022.9488525573692;1038.709161434792;10788.622398216103;10823.891761082366;10844;10844.668396294834;10875.891241087646;4160.563140870226;4202.054537728986;4251.0010147615285;4253.3194688849635;4283.764392958355;9283.767905802273;9286.396384235139;9302.441853488812;9314.627414903329;9316.720498384924;4746.549077837669;4773.427188737304;4785.808567657325;4786.018866132504;4787.257975013808;4263.445752052214;4282.700210985264;4298.742075475481;4327.2643650579475;4340.631046361094;3687.3362794697214;3691.593924668284;3705.7961812100593;3734.4398340248636;3744.344739670547;1154.3362566524281;1154.5612667186583;1157.0512180012477;1196.1925700152362;1205.3491114797912;1303.9348032598332;1307.078509650694;1336.5856584458654;1349.8515163332027;1350.8108864758942;7354.521956072838;7425.517341372793;7459.738909138154;7462.029936108272;7492.288232617892;457.13601293555206;462.51204978747745;467.7661169415292;468.03584615691784;471.86080106368706;5303.310569626001;5447.863803404946;6120.816375508742;6189.473894718909;6300.936990630035;8684.2184203422;8859.51272679996;8911.465312081296;9239.39943903644;9242.445453272825;9261.490618016074;9276.814463710689;9395.436273823592;9418;9421.576029078708;7140.821479462951;7163.7134514619875;7180.676869540779;7312.1591017033725;7350.595717235603;7367;7374.410047196104;7381.667824947997;7418.777436676908;7427.331540161412;8002.919970800217;8251.917480825115;8392.706255281037;8395.454295470774;8415.663373464993;8218.958905205436;8287.12985136576;8341.582920853813;8395.622197001028;8503.532305723245;7373.262673732584;7406.8148296290865;7440.590767507839;7457.067866516685;7491.737789177353;7520.811979700551;7623.847523049619;7625.428092892944;7627.466077374531;7629.465937384552;6959.512834101564;7202.819929501804;7207.423406127602;7326;7347.889781653173;6870.896936546056;6969.16370035599;7021;7093.787186384417;7215.025971493781;7011.789646310619;7062.329078737512;7096.645167741695;7096.645167741695;7099.325564071405;6363.681815909279;6433.517486188461;6443.420092191725;6447.129637499065;6458.806235812933;5490.203920431595;5632.662040277596;6411.839704007437;6420.229572451336;6535.869282614226 03:37:58 INFO - 2015-11-24 03:37:58,399 DEBUG : BROWSER_OUTPUT: |4;prototype.html;319.4202522421805;321.9002109346103;324.47921086655924;326.48089537635155;326.7924867709004;5864.09106588479;5951.910721339178;5958.612690175147;5973.940260597393;5982.670953097578;5582.748776305066;5708.514776244025;5721.084626459757;5886.087656413263;5886.440788125121;4557.840475583355;4570.7257564546235;4582.19811532982;4583.587477127058;4591.449026116862;4318.157959197958;4570.611498022672;4572.702774319659;4575.130725162225;4585.9541404586025;4345.543717909622;4393.319035549495;4532.320151977214;4551.658625603093;4555.476120246181;4506.1663592235545;4507.977460112678;4511.72929624222;4523.570260825217;4524.434445694288;3961.0889495415927;3967.3453880109746;3982.2433737589763;3985.4221137934837;3986.5216174059296;5511.311086114236;5612.382637909826;5614.775408983635;5619.381867994517;5628.774849006035;5276.366835979707;5281.551068159211;5287.788488460457;5295.205719142121;5296.576273898079;6266.561340706153;6279.120923070774;6279.654618995954;6280.654563998978;6282.717277722513;4417.469903611555;4419.955800441987;4423.845165419227;4424.02671412292;4428.955710442887;6343.936560634381;6503.544751867371;6503.869922601569;6508.64202468864;6515.283318834924;4517.819287228474;4519.389882365838;4520.118576877543;4520.773961301922;4520.81916723334;4573.702709323883;4574.428196475441;4580.908381832344;4582.633389328846;4586.610138138296;5267.394249661338;5273.6572122811895;5275.182346736262;5278.577713782888;5284.39229488606;6237.750489980441;6310.242770867525;6339.461145802658;6348.333424990402;6401.391867772554;1609.1793185475258;1632.0370981121196;1633.681432120725;1633.918304084791;1634.3135882929198;1100.9009189173014;1105.5633024955098;1106.8616422947132;1112.6884472347756;1129.768397478515;6138.877222455526;6155.230596175478;6156.969215153896;6158.199434073542;6160.876782464416;6530.477561795045;6544.607323560602;6548.312427195171;6559.409653131241;6566.967165164144;5991.221141251696;5998;6120.755169793248;6210.534209934273;6216.316205217422;3547.255076433926;3573;3583.211693427442;3584.874529391459;3587.6232995535615;6528.21661400635;6707.362800534039;6800.591964482147;6805.591664500146;6814.386705196556;6554.442872355903;6726.596404215763;6727.159105111861;6770.018347339608;6792.660366981631;6715.529912906148;6723.798286051427;6748.662566871637;6755.864882702318;6756.966215168893;6455.61266324022;6583.703733331916;6597.736090556324;6606.636634985122;6606.735730570916;6506.60960342381;6528.608283503005;6529.640869752209;6531.3468653134305;6535.477161826947;6790.898136528055;6801.081853949653;6804.727810887509;6809.625470599165;6815.488838337244;4448.154850578379;4469.44131983502;4485.955140448685;4546.977265113654;4552.635789136795;6553.279139294769;6553.344665533408;6556.213254409311;6559.311272316529;6565.179352580927;6405.3594640535575;6412;6418.229812422539;6423.389777971085;6423.775167869102;6274.245902937153;6356.618602883842;6396.264429590657;6400.45596124316;6400.807975760735;6271.3728627136925;6276.121343012073;6280.560360774884;6287.088372186099;6289.685515724287;6412.262589802046;6432.163818703539;6434.163558737334;6438.645874476949;6439.839004024937;6139.754409823736;6254.906176407267;6269.5611307208055;6269.655168965751;6277.027060805583 03:37:58 INFO - 2015-11-24 03:37:58,400 DEBUG : BROWSER_OUTPUT: |5;yui.html;704.4364508393287;726.7638017644267;735.8969744235807;813.6460639621765;851.5912362066206;13300.600981970532;13723.382447789849;13780.242086685228;13780.448782048707;13818.032737708365;11994.16040877139;12062.215955962856;12073.818892716594;12083;12083.818742718866;667.2560095493538;673.3603077076772;806.0931452116369;806.1374329467473;822.284612387224;814.4543156085437;821.0721884270765;825.5995842016617;826.669332267095;829.1045670675686;855.8202777416719;859.1709000814213;868.7480630617146;870.1689886158704;870.5690683111868;690.837653151509;698.6786078403941;846.2341580869293;859.3941271403645;863.3007264116023;633.8003528888386;637.7002808679913;640.9070684750685;641.0320416171568;641.3906788550895;12552.435140418704;12713.110082294243;12759.744805103846;12761.17052391601;12774.936125319315;11816.29102253859;12077.516899324017;12252.387380630933;12394.938025309906;12552.937235313857;10138.594456221743;10169.237307201916;10169.288149829516;10174.186065114847;10199.0820826126;3399.1332210286464;3448.4310088835314;3454.240067185215;3496.5629296337956;3569.250457403948;47842;48137.51862481365;48225.27662085072;48315.75842120802;48420.75789621065;9580.952095239618;9776.608935642636;9783.257702412184;9927.503624818875;9933.056359645821;17655.205515751823;17689.38087166943;17690.823091768918;17707.645847082986;17739.911300443673;7669.6548655309525;7700.383969282444;7836.412269079728;7881.211878812073;7896.249856263646;4082.6937979651643;4105.322621767435;4107;4146.315857883415;4257.531671516131;2924.6344206974127;2958.3195864950753;2961.3633068889862;2966.5401862711315;2971.242333205062;521.7391304347826;522.1723568144533;527.0907684244647;532.3957308454932;539.2719828231934;550.8292429346915;601.9548533859978;626.8558231606756;655.9081728558006;661.986760264792;8515.19105684959;8520.659173632985;8615.439996400213;8663.566821658891;8746.825063498694;544.2407841061776;545.8992920213147;693.5076095971816;695.9060526828914;724.7789424225662;3960.2277555876326;4113.814878330482;4188;4219.177260434186;4230.915381692349;58260.70869645625;58262;58467.122993155135;58584.70707646434;58916.70541647264;47020.764896175984;47068.7646561765;47189.29216061762;47734.28398574024;47827;44948;46045.079098418515;46395.30407043897;46398.76800615976;47093.5290647096;8451.704190353308;8504.829903402022;8746.30029597618;8810.295176385745;8843.46939183651;33174;34014.65985340115;34474.31051378908;34486.13784655404;34890.65109348874;45395.54604454045;45902.770486147354;46601.407831059136;47258;47288.527114728415;10805.621803237163;10828;10852.782944340912;11180.217384782987;11373.772524549628;12261.495151704808;12361.258324500199;12369.62891113268;12496.500139994298;12586.24482531051;10813.956380095062;11049.28179668319;11559.479823407799;11641.952224299854;11966.70083247891;11351.432428378383;11456.599019034295;11497.827532587185;11628.360440175871;12073.39633018328;8051.959740201261;10488;11437.42812859337;11479;11717.32697230861;10047;10107.646232382125;10252.538635761259;10518.789624207626;10593.629222977159;8434.70478533273;9375.34372593912;9920.355176913477;9990.000999899952;10003.549840257352 03:37:58 INFO - 2015-11-24 03:37:58,401 DEBUG : BROWSER_OUTPUT: __end_tp_report 03:37:58 INFO - 2015-11-24 03:37:58,401 DEBUG : BROWSER_OUTPUT: __start_cc_report 03:37:58 INFO - 2015-11-24 03:37:58,401 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,1787 03:37:58 INFO - 2015-11-24 03:37:58,401 DEBUG : BROWSER_OUTPUT: __end_cc_report 03:37:58 INFO - 2015-11-24 03:37:58,401 DEBUG : BROWSER_OUTPUT: __startTimestamp1448365078390__endTimestamp 03:37:58 INFO - 2015-11-24 03:37:58,401 DEBUG : BROWSER_OUTPUT: 03:37:58 INFO - 2015-11-24 03:37:58,401 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 03:37:58 INFO - 2015-11-24 03:37:58,401 DEBUG : BROWSER_OUTPUT: Number of tests: 6 03:37:58 INFO - 2015-11-24 03:37:58,402 DEBUG : BROWSER_OUTPUT: 03:37:58 INFO - 2015-11-24 03:37:58,402 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:5463.31 Median:5674.15 stddev:598.75 (10.6%) stddev-sans-first:573.65 03:37:58 INFO - 2015-11-24 03:37:58,402 DEBUG : BROWSER_OUTPUT: Values: 3199.7 3291.6 3324.4 3324.7 3340.5 5281.3 5377.3 5452.7 5490.8 5542.1 5420.2 5426.4 5479.8 5480.0 5546.9 5005.5 5013.0 5025.2 5037.7 5093.9 4895.9 5030.3 5050.7 5107.9 5140.4 4899.6 5017.5 5023.5 5025.6 5054.3 4988.3 4990.7 4991.2 4994.2 5039.2 4840.6 4970.8 4975.2 4985.2 5036.3 5174.7 5184.5 5257.7 5275.0 5303.3 5985.5 6008.6 6011.9 6017.2 6020.9 5587.5 5707.0 6010.2 6020.6 6030.3 5417.0 5480.9 5519.0 5527.7 5540.6 5903.0 5906.8 5920.1 5923.4 5937.2 5682.9 5727.9 5754.3 5756.8 5822.2 5764.5 5822.3 5866.3 5911.6 5965.3 5806.2 5875.7 5889.7 5894.0 5896.1 5660.5 5867.6 5880.7 5895.2 5903.0 4499.4 4534.2 4547.2 4550.5 4578.2 4065.6 4084.3 4088.2 4090.4 4128.9 5333.2 5651.5 5664.8 5667.5 5670.2 5729.5 5776.1 5817.6 5861.2 5886.1 5595.8 5674.1 5681.4 5687.9 5688.9 4979.7 5190.9 5202.9 5213.0 5262.3 6028.1 6050.3 6117.6 6125.4 6126.1 5886.6 5970.8 5973.2 5975.9 5978.3 5772.4 5885.5 6143.7 6158.2 6166.9 5780.6 5789.9 5880.6 5882.7 5934.9 5893.4 5915.9 5916.8 5919.3 5924.7 5628.7 5742.4 5791.7 5792.1 5805.8 5656.5 5691.7 5715.5 5716.6 5718.7 5568.7 5569.4 5571.0 5574.7 5575.0 5627.6 5671.1 5707.5 5736.2 5816.6 5714.5 5720.2 5723.1 5723.2 5764.4 03:37:58 INFO - 2015-11-24 03:37:58,402 DEBUG : BROWSER_OUTPUT: 03:37:58 INFO - 2015-11-24 03:37:58,402 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:45124.51 Median:18197.45 stddev:73048.39 (401.4%) stddev-sans-first:73176.59 03:37:58 INFO - 2015-11-24 03:37:58,402 DEBUG : BROWSER_OUTPUT: Values: 537.1 596.7 596.9 599.6 602.9 30807.2 32080.0 40361.4 40863.2 40887.8 42762.8 43167.1 43228.1 43325.8 43330.0 7756.2 8774.3 8926.6 8936.2 8949.1 7742.2 7838.0 10523.8 10795.8 10797.2 10474.6 10557.5 10565.3 10567.8 10577.7 7857.4 8037.3 10361.6 10361.7 10427.0 7731.8 7839.6 7842.2 10563.9 10871.9 39151.2 39425.8 39626.6 39628.4 39631.6 3300.8 3331.2 3364.3 3637.3 4050.2 29619.9 29689.9 29842.4 30361.7 30895.2 3791.4 3919.7 3964.9 4030.3 4130.4 260598.0 262447.7 262540.0 262717.0 262868.0 57481.4 57670.7 57914.4 57929.4 58054.0 54001.7 55620.3 61973.0 62240.0 62247.7 13923.9 14323.9 14327.6 16404.8 16806.3 11377.0 11459.2 11537.0 11545.9 11569.9 16462.6 19428.1 19452.4 19551.8 19594.2 6637.3 7552.9 7658.2 7668.3 7694.8 949.5 965.3 976.4 1029.3 1130.5 26460.0 27308.0 27539.0 27591.9 27821.9 1000.3 1011.1 1016.1 1091.7 1128.0 14404.4 14528.8 14613.2 14696.4 14833.9 289582.0 292136.0 292361.0 292593.0 293492.0 52599.7 52692.5 53103.0 53192.0 53220.7 1302.8 1354.2 1374.3 1377.4 1383.5 26589.3 26815.9 27418.1 27676.9 27745.7 43708.3 44317.0 44830.8 45419.8 45517.5 279980.0 285931.0 286877.0 287357.0 288039.0 30145.7 30604.8 30610.4 30617.2 30661.0 39341.4 40334.2 40777.8 41274.4 41417.6 36092.0 36841.0 36965.4 37018.4 40213.4 35269.5 35999.0 36062.6 36506.5 36582.3 35339.5 36365.1 36741.6 36754.8 36760.8 30944.0 31748.7 33063.7 33482.7 33550.7 25309.2 25505.5 25717.0 25746.6 25867.7 03:37:58 INFO - 2015-11-24 03:37:58,402 DEBUG : BROWSER_OUTPUT: 03:37:58 INFO - 2015-11-24 03:37:58,403 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:27944.34 Median:352.14 stddev:82434.29 (23409.7%) stddev-sans-first:82639.50 03:37:58 INFO - 2015-11-24 03:37:58,404 DEBUG : BROWSER_OUTPUT: Values: 351.2 353.1 354.5 355.6 359.8 14272.2 14764.0 15983.8 16488.9 17199.2 16354.8 16972.9 16987.7 17470.0 17499.5 5261.9 5427.4 5427.9 5430.0 5431.7 4111.4 4260.0 5405.2 5947.8 6109.0 5884.9 5998.5 6015.7 6046.6 6047.3 6088.1 6093.9 6149.2 6164.6 6169.3 5232.7 5315.7 5352.5 5366.9 5371.3 21343.4 21537.2 21715.7 21783.3 21971.3 2203.5 2214.0 2281.3 2321.5 2345.6 13391.5 13570.2 13631.9 13990.7 14172.8 1764.1 1837.4 1856.7 1869.3 1893.5 59988.7 63069.4 63637.7 64333.4 65665.0 9466.4 9522.0 9717.9 10074.2 10117.3 13032.9 13113.7 13208.1 13248.9 13250.1 7558.3 7612.1 7616.9 7682.2 7695.3 7327.0 7386.5 7386.6 7453.3 7456.6 5579.3 6024.1 6092.9 6115.2 6126.6 1662.7 1729.6 1750.1 1768.8 1778.2 388.9 399.2 400.0 411.8 1002.3 10412.9 10550.3 10950.2 11049.9 11069.5 431.8 431.9 435.2 458.9 467.5 9736.8 9920.5 10142.7 10249.6 10374.7 471087.0 476219.0 501952.0 532236.0 532448.0 80243.0 81827.6 81854.6 82314.6 82535.0 1142.7 1155.8 1161.9 1165.5 1165.5 12889.5 15248.0 15370.2 15843.9 15857.7 33523.3 33634.3 33822.0 34434.8 34562.7 49807.0 50985.2 51800.2 52449.0 52641.5 9430.0 9604.0 9627.3 9727.0 9752.8 11306.8 11340.0 11352.5 11406.3 12911.7 14855.9 14885.9 15112.8 15205.4 15231.8 13892.5 14407.0 14471.9 14808.9 15109.2 14545.4 14796.7 14910.1 15180.5 15258.2 9049.5 9133.1 9299.2 9477.4 9502.5 9579.8 10387.5 14497.6 15155.8 15287.0 03:37:58 INFO - 2015-11-24 03:37:58,404 DEBUG : BROWSER_OUTPUT: 03:37:58 INFO - 2015-11-24 03:37:58,404 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5441.09 Median:6416.03 stddev:2867.90 (44.7%) stddev-sans-first:2859.26 03:37:58 INFO - 2015-11-24 03:37:58,404 DEBUG : BROWSER_OUTPUT: Values: 1325.3 1457.1 1479.6 1634.9 1783.3 6511.6 7668.3 7847.5 7852.1 7853.0 7635.5 7776.7 7782.8 7783.6 7797.6 1936.7 1965.0 1966.9 2216.2 2238.6 2213.7 2240.0 2244.1 2245.4 2245.5 2179.7 2202.3 2208.1 2241.8 2247.9 1952.7 1987.4 2128.9 2199.8 2229.3 2225.7 2235.2 2235.8 2236.3 2238.6 7573.4 7591.6 7592.0 7625.9 7628.1 4592.0 4644.5 4659.0 4660.2 4687.3 2948.9 2967.4 3036.7 3055.7 3068.4 959.4 962.9 997.3 1022.9 1038.7 10788.6 10823.9 10844.0 10844.7 10875.9 4160.6 4202.1 4251.0 4253.3 4283.8 9283.8 9286.4 9302.4 9314.6 9316.7 4746.5 4773.4 4785.8 4786.0 4787.3 4263.4 4282.7 4298.7 4327.3 4340.6 3687.3 3691.6 3705.8 3734.4 3744.3 1154.3 1154.6 1157.1 1196.2 1205.3 1303.9 1307.1 1336.6 1349.9 1350.8 7354.5 7425.5 7459.7 7462.0 7492.3 457.1 462.5 467.8 468.0 471.9 5303.3 5447.9 6120.8 6189.5 6300.9 8684.2 8859.5 8911.5 9239.4 9242.4 9261.5 9276.8 9395.4 9418.0 9421.6 7140.8 7163.7 7180.7 7312.2 7350.6 7367.0 7374.4 7381.7 7418.8 7427.3 8002.9 8251.9 8392.7 8395.5 8415.7 8219.0 8287.1 8341.6 8395.6 8503.5 7373.3 7406.8 7440.6 7457.1 7491.7 7520.8 7623.8 7625.4 7627.5 7629.5 6959.5 7202.8 7207.4 7326.0 7347.9 6870.9 6969.2 7021.0 7093.8 7215.0 7011.8 7062.3 7096.6 7096.6 7099.3 6363.7 6433.5 6443.4 6447.1 6458.8 5490.2 5632.7 6411.8 6420.2 6535.9 03:37:58 INFO - 2015-11-24 03:37:58,404 DEBUG : BROWSER_OUTPUT: 03:37:58 INFO - 2015-11-24 03:37:58,405 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:5301.85 Median:5994.61 stddev:1596.10 (26.6%) stddev-sans-first:1556.15 03:37:58 INFO - 2015-11-24 03:37:58,406 DEBUG : BROWSER_OUTPUT: Values: 319.4 321.9 324.5 326.5 326.8 5864.1 5951.9 5958.6 5973.9 5982.7 5582.7 5708.5 5721.1 5886.1 5886.4 4557.8 4570.7 4582.2 4583.6 4591.4 4318.2 4570.6 4572.7 4575.1 4586.0 4345.5 4393.3 4532.3 4551.7 4555.5 4506.2 4508.0 4511.7 4523.6 4524.4 3961.1 3967.3 3982.2 3985.4 3986.5 5511.3 5612.4 5614.8 5619.4 5628.8 5276.4 5281.6 5287.8 5295.2 5296.6 6266.6 6279.1 6279.7 6280.7 6282.7 4417.5 4420.0 4423.8 4424.0 4429.0 6343.9 6503.5 6503.9 6508.6 6515.3 4517.8 4519.4 4520.1 4520.8 4520.8 4573.7 4574.4 4580.9 4582.6 4586.6 5267.4 5273.7 5275.2 5278.6 5284.4 6237.8 6310.2 6339.5 6348.3 6401.4 1609.2 1632.0 1633.7 1633.9 1634.3 1100.9 1105.6 1106.9 1112.7 1129.8 6138.9 6155.2 6157.0 6158.2 6160.9 6530.5 6544.6 6548.3 6559.4 6567.0 5991.2 5998.0 6120.8 6210.5 6216.3 3547.3 3573.0 3583.2 3584.9 3587.6 6528.2 6707.4 6800.6 6805.6 6814.4 6554.4 6726.6 6727.2 6770.0 6792.7 6715.5 6723.8 6748.7 6755.9 6757.0 6455.6 6583.7 6597.7 6606.6 6606.7 6506.6 6528.6 6529.6 6531.3 6535.5 6790.9 6801.1 6804.7 6809.6 6815.5 4448.2 4469.4 4486.0 4547.0 4552.6 6553.3 6553.3 6556.2 6559.3 6565.2 6405.4 6412.0 6418.2 6423.4 6423.8 6274.2 6356.6 6396.3 6400.5 6400.8 6271.4 6276.1 6280.6 6287.1 6289.7 6412.3 6432.2 6434.2 6438.6 6439.8 6139.8 6254.9 6269.6 6269.7 6277.0 03:37:58 INFO - 2015-11-24 03:37:58,406 DEBUG : BROWSER_OUTPUT: 03:37:58 INFO - 2015-11-24 03:37:58,406 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:13677.84 Median:46500.09 stddev:15853.20 (34.1%) stddev-sans-first:15867.74 03:37:58 INFO - 2015-11-24 03:37:58,406 DEBUG : BROWSER_OUTPUT: Values: 704.4 726.8 735.9 813.6 851.6 13300.6 13723.4 13780.2 13780.4 13818.0 11994.2 12062.2 12073.8 12083.0 12083.8 667.3 673.4 806.1 806.1 822.3 814.5 821.1 825.6 826.7 829.1 855.8 859.2 868.7 870.2 870.6 690.8 698.7 846.2 859.4 863.3 633.8 637.7 640.9 641.0 641.4 12552.4 12713.1 12759.7 12761.2 12774.9 11816.3 12077.5 12252.4 12394.9 12552.9 10138.6 10169.2 10169.3 10174.2 10199.1 3399.1 3448.4 3454.2 3496.6 3569.3 47842.0 48137.5 48225.3 48315.8 48420.8 9581.0 9776.6 9783.3 9927.5 9933.1 17655.2 17689.4 17690.8 17707.6 17739.9 7669.7 7700.4 7836.4 7881.2 7896.2 4082.7 4105.3 4107.0 4146.3 4257.5 2924.6 2958.3 2961.4 2966.5 2971.2 521.7 522.2 527.1 532.4 539.3 550.8 602.0 626.9 655.9 662.0 8515.2 8520.7 8615.4 8663.6 8746.8 544.2 545.9 693.5 695.9 724.8 3960.2 4113.8 4188.0 4219.2 4230.9 58260.7 58262.0 58467.1 58584.7 58916.7 47020.8 47068.8 47189.3 47734.3 47827.0 44948.0 46045.1 46395.3 46398.8 47093.5 8451.7 8504.8 8746.3 8810.3 8843.5 33174.0 34014.7 34474.3 34486.1 34890.7 45395.5 45902.8 46601.4 47258.0 47288.5 10805.6 10828.0 10852.8 11180.2 11373.8 12261.5 12361.3 12369.6 12496.5 12586.2 10814.0 11049.3 11559.5 11642.0 11966.7 11351.4 11456.6 11497.8 11628.4 12073.4 8052.0 10488.0 11437.4 11479.0 11717.3 10047.0 10107.6 10252.5 10518.8 10593.6 8434.7 9375.3 9920.4 9990.0 10003.5 03:37:58 INFO - 2015-11-24 03:37:58,406 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 03:37:58 INFO - 2015-11-24 03:37:58,406 DEBUG : BROWSER_OUTPUT: 03:37:59 INFO - 2015-11-24 03:37:59,117 INFO : Browser exited with error code: 0 03:37:59 INFO - 2015-11-24 03:37:59,136 INFO : Completed test dromaeo_css (00:18:33) 03:37:59 INFO - 2015-11-24 03:37:59,136 INFO : Starting test kraken 03:37:59 INFO - 2015-11-24 03:37:59,136 DEBUG : operating with platform_type : linux_ 03:37:59 INFO - 2015-11-24 03:37:59,136 INFO : Initialising browser for kraken test... 03:37:59 INFO - 2015-11-24 03:37:59,142 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpUDdFFJ/profile http://localhost:43003/getInfo.html 03:38:02 INFO - 2015-11-24 03:38:02,919 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 03:38:02 INFO - 2015-11-24 03:38:02,919 DEBUG : BROWSER_OUTPUT: colorDepth:24 03:38:02 INFO - 2015-11-24 03:38:02,919 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 03:38:02 INFO - 2015-11-24 03:38:02,920 DEBUG : BROWSER_OUTPUT: __metrics 03:38:02 INFO - 2015-11-24 03:38:02,996 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 03:38:04 INFO - 2015-11-24 03:38:04,311 INFO : Browser initialized. 03:38:04 INFO - 2015-11-24 03:38:04,312 INFO : Running cycle 1/1 for kraken test... 03:38:04 INFO - 2015-11-24 03:38:04,312 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpUDdFFJ/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 03:38:16 INFO - 2015-11-24 03:38:16,023 DEBUG : BROWSER_OUTPUT: RSS: Main: 142573568 03:38:16 INFO - 2015-11-24 03:38:16,023 DEBUG : BROWSER_OUTPUT: 03:38:18 INFO - 2015-11-24 03:38:18,470 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43003/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:43003/tests/kraken/driver.html?testName=audio-beat-detection) 03:38:19 INFO - 2015-11-24 03:38:19,051 DEBUG : BROWSER_OUTPUT: RSS: Main: 177950720 03:38:19 INFO - 2015-11-24 03:38:19,051 DEBUG : BROWSER_OUTPUT: 03:38:21 INFO - 2015-11-24 03:38:21,660 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43003/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:43003/tests/kraken/driver.html?testName=audio-dft) 03:38:22 INFO - 2015-11-24 03:38:22,227 DEBUG : BROWSER_OUTPUT: RSS: Main: 168931328 03:38:22 INFO - 2015-11-24 03:38:22,227 DEBUG : BROWSER_OUTPUT: 03:38:25 INFO - 2015-11-24 03:38:25,073 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43003/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:43003/tests/kraken/driver.html?testName=audio-fft) 03:38:25 INFO - 2015-11-24 03:38:25,634 DEBUG : BROWSER_OUTPUT: RSS: Main: 151576576 03:38:25 INFO - 2015-11-24 03:38:25,634 DEBUG : BROWSER_OUTPUT: 03:38:27 INFO - 2015-11-24 03:38:27,607 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43003/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:43003/tests/kraken/driver.html?testName=audio-oscillator) 03:38:28 INFO - 2015-11-24 03:38:28,167 DEBUG : BROWSER_OUTPUT: RSS: Main: 154525696 03:38:28 INFO - 2015-11-24 03:38:28,168 DEBUG : BROWSER_OUTPUT: 03:38:30 INFO - 2015-11-24 03:38:30,353 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43003/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:43003/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:38:30 INFO - 2015-11-24 03:38:30,918 DEBUG : BROWSER_OUTPUT: RSS: Main: 156303360 03:38:30 INFO - 2015-11-24 03:38:30,919 DEBUG : BROWSER_OUTPUT: 03:38:33 INFO - 2015-11-24 03:38:33,805 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43003/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:43003/tests/kraken/driver.html?testName=imaging-darkroom) 03:38:34 INFO - 2015-11-24 03:38:34,373 DEBUG : BROWSER_OUTPUT: RSS: Main: 155226112 03:38:34 INFO - 2015-11-24 03:38:34,374 DEBUG : BROWSER_OUTPUT: 03:38:37 INFO - 2015-11-24 03:38:37,743 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43003/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:43003/tests/kraken/driver.html?testName=imaging-desaturate) 03:38:38 INFO - 2015-11-24 03:38:38,310 DEBUG : BROWSER_OUTPUT: RSS: Main: 156082176 03:38:38 INFO - 2015-11-24 03:38:38,310 DEBUG : BROWSER_OUTPUT: 03:38:41 INFO - 2015-11-24 03:38:41,060 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43003/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:43003/tests/kraken/driver.html?testName=json-parse-financial) 03:38:41 INFO - 2015-11-24 03:38:41,634 DEBUG : BROWSER_OUTPUT: RSS: Main: 156184576 03:38:41 INFO - 2015-11-24 03:38:41,634 DEBUG : BROWSER_OUTPUT: 03:38:43 INFO - 2015-11-24 03:38:43,154 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43003/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:43003/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:38:43 INFO - 2015-11-24 03:38:43,720 DEBUG : BROWSER_OUTPUT: RSS: Main: 170012672 03:38:43 INFO - 2015-11-24 03:38:43,721 DEBUG : BROWSER_OUTPUT: 03:38:45 INFO - 2015-11-24 03:38:45,531 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43003/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:43003/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:38:46 INFO - 2015-11-24 03:38:46,132 DEBUG : BROWSER_OUTPUT: RSS: Main: 167919616 03:38:46 INFO - 2015-11-24 03:38:46,133 DEBUG : BROWSER_OUTPUT: 03:38:48 INFO - 2015-11-24 03:38:48,185 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43003/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:43003/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:38:48 INFO - 2015-11-24 03:38:48,758 DEBUG : BROWSER_OUTPUT: RSS: Main: 173916160 03:38:48 INFO - 2015-11-24 03:38:48,759 DEBUG : BROWSER_OUTPUT: 03:38:51 INFO - 2015-11-24 03:38:51,145 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43003/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:43003/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:38:51 INFO - 2015-11-24 03:38:51,727 DEBUG : BROWSER_OUTPUT: RSS: Main: 180670464 03:38:51 INFO - 2015-11-24 03:38:51,727 DEBUG : BROWSER_OUTPUT: 03:38:54 INFO - 2015-11-24 03:38:54,254 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43003/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:43003/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:38:54 INFO - 2015-11-24 03:38:54,820 DEBUG : BROWSER_OUTPUT: RSS: Main: 180592640 03:38:54 INFO - 2015-11-24 03:38:54,821 DEBUG : BROWSER_OUTPUT: 03:38:56 INFO - 2015-11-24 03:38:56,474 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43003/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:43003/tests/kraken/driver.html?testName=ai-astar) 03:38:56 INFO - 2015-11-24 03:38:56,732 DEBUG : BROWSER_OUTPUT: RSS: Main: 239853568 03:38:56 INFO - 2015-11-24 03:38:56,732 DEBUG : BROWSER_OUTPUT: 03:38:56 INFO - 2015-11-24 03:38:56,732 DEBUG : BROWSER_OUTPUT: __start_tp_report 03:38:56 INFO - 2015-11-24 03:38:56,732 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 03:38:56 INFO - 2015-11-24 03:38:56,733 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 03:38:56 INFO - 2015-11-24 03:38:56,733 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 03:38:56 INFO - 2015-11-24 03:38:56,733 DEBUG : BROWSER_OUTPUT: |0;ai-astar;108;110;105;111;111;111;99;110;109;99 03:38:56 INFO - 2015-11-24 03:38:56,733 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;148;126;147;162;133;157;151;124;172;125 03:38:56 INFO - 2015-11-24 03:38:56,733 DEBUG : BROWSER_OUTPUT: |2;audio-dft;161;162;162;160;159;160;161;163;161;161 03:38:56 INFO - 2015-11-24 03:38:56,733 DEBUG : BROWSER_OUTPUT: |3;audio-fft;73;71;89;93;71;71;72;126;102;71 03:38:56 INFO - 2015-11-24 03:38:56,733 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;93;93;142;93;94;93;138;93;94;141 03:38:56 INFO - 2015-11-24 03:38:56,733 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;109;110;109;109;110;109;110;109;110;110 03:38:56 INFO - 2015-11-24 03:38:56,733 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;145;146;145;145;146;145;146;146;146;147 03:38:56 INFO - 2015-11-24 03:38:56,733 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;96;95;97;96;96;96;95;95;96;96 03:38:56 INFO - 2015-11-24 03:38:56,733 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;58;56;56;56;56;57;58;56;59;56 03:38:56 INFO - 2015-11-24 03:38:56,733 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;68;69;69;69;70;70;70;70;69;69 03:38:56 INFO - 2015-11-24 03:38:56,733 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;84;84;85;86;86;93;85;84;85;93 03:38:56 INFO - 2015-11-24 03:38:56,733 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;117;123;131;112;123;116;123;123;122;119 03:38:56 INFO - 2015-11-24 03:38:56,733 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;138;149;149;149;148;137;149;149;147;139 03:38:56 INFO - 2015-11-24 03:38:56,734 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;68;68;66;66;67;66;67;68;67;67 03:38:56 INFO - 2015-11-24 03:38:56,734 DEBUG : BROWSER_OUTPUT: __end_tp_report 03:38:56 INFO - 2015-11-24 03:38:56,734 DEBUG : BROWSER_OUTPUT: __start_cc_report 03:38:56 INFO - 2015-11-24 03:38:56,734 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,901 03:38:56 INFO - 2015-11-24 03:38:56,734 DEBUG : BROWSER_OUTPUT: __end_cc_report 03:38:56 INFO - 2015-11-24 03:38:56,734 DEBUG : BROWSER_OUTPUT: __startTimestamp1448365136726__endTimestamp 03:38:56 INFO - 2015-11-24 03:38:56,734 DEBUG : BROWSER_OUTPUT: 03:38:56 INFO - 2015-11-24 03:38:56,734 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 03:38:56 INFO - 2015-11-24 03:38:56,734 DEBUG : BROWSER_OUTPUT: Number of tests: 14 03:38:56 INFO - 2015-11-24 03:38:56,734 DEBUG : BROWSER_OUTPUT: 03:38:56 INFO - 2015-11-24 03:38:56,734 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:107.30 Median:111.00 stddev:4.74 (4.3%) stddev-sans-first:5.02 03:38:56 INFO - 2015-11-24 03:38:56,735 DEBUG : BROWSER_OUTPUT: Values: 108.0 110.0 105.0 111.0 111.0 111.0 99.0 110.0 109.0 99.0 03:38:56 INFO - 2015-11-24 03:38:56,735 DEBUG : BROWSER_OUTPUT: 03:38:56 INFO - 2015-11-24 03:38:56,735 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:144.50 Median:149.50 stddev:16.85 (11.3%) stddev-sans-first:17.82 03:38:56 INFO - 2015-11-24 03:38:56,735 DEBUG : BROWSER_OUTPUT: Values: 148.0 126.0 147.0 162.0 133.0 157.0 151.0 124.0 172.0 125.0 03:38:56 INFO - 2015-11-24 03:38:56,735 DEBUG : BROWSER_OUTPUT: 03:38:56 INFO - 2015-11-24 03:38:56,735 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:161.00 Median:161.00 stddev:1.15 (0.7%) stddev-sans-first:1.22 03:38:56 INFO - 2015-11-24 03:38:56,735 DEBUG : BROWSER_OUTPUT: Values: 161.0 162.0 162.0 160.0 159.0 160.0 161.0 163.0 161.0 161.0 03:38:56 INFO - 2015-11-24 03:38:56,735 DEBUG : BROWSER_OUTPUT: 03:38:56 INFO - 2015-11-24 03:38:56,736 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:83.90 Median:71.50 stddev:18.66 (26.1%) stddev-sans-first:19.37 03:38:56 INFO - 2015-11-24 03:38:56,736 DEBUG : BROWSER_OUTPUT: Values: 73.0 71.0 89.0 93.0 71.0 71.0 72.0 126.0 102.0 71.0 03:38:56 INFO - 2015-11-24 03:38:56,736 DEBUG : BROWSER_OUTPUT: 03:38:56 INFO - 2015-11-24 03:38:56,736 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:107.40 Median:93.00 stddev:22.75 (24.5%) stddev-sans-first:23.53 03:38:56 INFO - 2015-11-24 03:38:56,736 DEBUG : BROWSER_OUTPUT: Values: 93.0 93.0 142.0 93.0 94.0 93.0 138.0 93.0 94.0 141.0 03:38:56 INFO - 2015-11-24 03:38:56,736 DEBUG : BROWSER_OUTPUT: 03:38:56 INFO - 2015-11-24 03:38:56,736 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:109.50 Median:110.00 stddev:0.53 (0.5%) stddev-sans-first:0.53 03:38:56 INFO - 2015-11-24 03:38:56,736 DEBUG : BROWSER_OUTPUT: Values: 109.0 110.0 109.0 109.0 110.0 109.0 110.0 109.0 110.0 110.0 03:38:56 INFO - 2015-11-24 03:38:56,736 DEBUG : BROWSER_OUTPUT: 03:38:56 INFO - 2015-11-24 03:38:56,736 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:145.70 Median:146.00 stddev:0.67 (0.5%) stddev-sans-first:0.67 03:38:56 INFO - 2015-11-24 03:38:56,736 DEBUG : BROWSER_OUTPUT: Values: 145.0 146.0 145.0 145.0 146.0 145.0 146.0 146.0 146.0 147.0 03:38:56 INFO - 2015-11-24 03:38:56,736 DEBUG : BROWSER_OUTPUT: 03:38:56 INFO - 2015-11-24 03:38:56,736 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:95.80 Median:96.00 stddev:0.63 (0.7%) stddev-sans-first:0.67 03:38:56 INFO - 2015-11-24 03:38:56,736 DEBUG : BROWSER_OUTPUT: Values: 96.0 95.0 97.0 96.0 96.0 96.0 95.0 95.0 96.0 96.0 03:38:56 INFO - 2015-11-24 03:38:56,736 DEBUG : BROWSER_OUTPUT: 03:38:56 INFO - 2015-11-24 03:38:56,736 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:56.80 Median:56.50 stddev:1.14 (2.0%) stddev-sans-first:1.12 03:38:56 INFO - 2015-11-24 03:38:56,737 DEBUG : BROWSER_OUTPUT: Values: 58.0 56.0 56.0 56.0 56.0 57.0 58.0 56.0 59.0 56.0 03:38:56 INFO - 2015-11-24 03:38:56,737 DEBUG : BROWSER_OUTPUT: 03:38:56 INFO - 2015-11-24 03:38:56,737 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:69.30 Median:69.50 stddev:0.67 (1.0%) stddev-sans-first:0.53 03:38:56 INFO - 2015-11-24 03:38:56,737 DEBUG : BROWSER_OUTPUT: Values: 68.0 69.0 69.0 69.0 70.0 70.0 70.0 70.0 69.0 69.0 03:38:56 INFO - 2015-11-24 03:38:56,737 DEBUG : BROWSER_OUTPUT: 03:38:56 INFO - 2015-11-24 03:38:56,737 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:86.50 Median:85.50 stddev:3.50 (4.1%) stddev-sans-first:3.60 03:38:56 INFO - 2015-11-24 03:38:56,737 DEBUG : BROWSER_OUTPUT: Values: 84.0 84.0 85.0 86.0 86.0 93.0 85.0 84.0 85.0 93.0 03:38:56 INFO - 2015-11-24 03:38:56,737 DEBUG : BROWSER_OUTPUT: 03:38:56 INFO - 2015-11-24 03:38:56,737 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:120.90 Median:123.00 stddev:5.20 (4.2%) stddev-sans-first:5.32 03:38:56 INFO - 2015-11-24 03:38:56,737 DEBUG : BROWSER_OUTPUT: Values: 117.0 123.0 131.0 112.0 123.0 116.0 123.0 123.0 122.0 119.0 03:38:56 INFO - 2015-11-24 03:38:56,737 DEBUG : BROWSER_OUTPUT: 03:38:56 INFO - 2015-11-24 03:38:56,737 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:145.40 Median:149.00 stddev:5.17 (3.5%) stddev-sans-first:4.74 03:38:56 INFO - 2015-11-24 03:38:56,737 DEBUG : BROWSER_OUTPUT: Values: 138.0 149.0 149.0 149.0 148.0 137.0 149.0 149.0 147.0 139.0 03:38:56 INFO - 2015-11-24 03:38:56,737 DEBUG : BROWSER_OUTPUT: 03:38:56 INFO - 2015-11-24 03:38:56,737 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.00 Median:67.00 stddev:0.82 (1.2%) stddev-sans-first:0.78 03:38:56 INFO - 2015-11-24 03:38:56,737 DEBUG : BROWSER_OUTPUT: Values: 68.0 68.0 66.0 66.0 67.0 66.0 67.0 68.0 67.0 67.0 03:38:56 INFO - 2015-11-24 03:38:56,738 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 03:38:56 INFO - 2015-11-24 03:38:56,738 DEBUG : BROWSER_OUTPUT: 03:38:57 INFO - 2015-11-24 03:38:57,621 INFO : Browser exited with error code: 0 03:38:57 INFO - 2015-11-24 03:38:57,673 INFO : Completed test kraken (00:00:58) 03:38:57 INFO - 2015-11-24 03:38:57,673 INFO : Starting test v8_7 03:38:57 INFO - 2015-11-24 03:38:57,673 DEBUG : operating with platform_type : linux_ 03:38:57 INFO - 2015-11-24 03:38:57,673 INFO : Initialising browser for v8_7 test... 03:38:57 INFO - 2015-11-24 03:38:57,679 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpeOsYzD/profile http://localhost:43003/getInfo.html 03:39:01 INFO - 2015-11-24 03:39:01,360 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 03:39:01 INFO - 2015-11-24 03:39:01,360 DEBUG : BROWSER_OUTPUT: colorDepth:24 03:39:01 INFO - 2015-11-24 03:39:01,360 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 03:39:01 INFO - 2015-11-24 03:39:01,360 DEBUG : BROWSER_OUTPUT: __metrics 03:39:01 INFO - 2015-11-24 03:39:01,489 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 03:39:02 INFO - 2015-11-24 03:39:02,600 INFO : Browser initialized. 03:39:02 INFO - 2015-11-24 03:39:02,600 INFO : Running cycle 1/1 for v8_7 test... 03:39:02 INFO - 2015-11-24 03:39:02,600 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpeOsYzD/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 03:39:14 INFO - 2015-11-24 03:39:14,323 DEBUG : BROWSER_OUTPUT: RSS: Main: 140435456 03:39:14 INFO - 2015-11-24 03:39:14,323 DEBUG : BROWSER_OUTPUT: 03:39:35 INFO - 2015-11-24 03:39:35,747 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43003/tests/v8_7/run.html (next: http://localhost:43003/tests/v8_7/run.html) 03:39:35 INFO - 2015-11-24 03:39:35,997 DEBUG : BROWSER_OUTPUT: RSS: Main: 471027712 03:39:35 INFO - 2015-11-24 03:39:35,997 DEBUG : BROWSER_OUTPUT: 03:39:35 INFO - 2015-11-24 03:39:35,998 DEBUG : BROWSER_OUTPUT: __start_tp_report 03:39:35 INFO - 2015-11-24 03:39:35,998 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 03:39:35 INFO - 2015-11-24 03:39:35,998 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 03:39:35 INFO - 2015-11-24 03:39:35,998 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 03:39:36 INFO - 2015-11-24 03:39:35,998 DEBUG : BROWSER_OUTPUT: |0;Richards;190.7304978065993 03:39:36 INFO - 2015-11-24 03:39:35,998 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;194.55252918287937 03:39:36 INFO - 2015-11-24 03:39:35,998 DEBUG : BROWSER_OUTPUT: |2;Encrypt;286.4508736751647 03:39:36 INFO - 2015-11-24 03:39:35,999 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5010 03:39:36 INFO - 2015-11-24 03:39:35,999 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1101.2101210121011 03:39:36 INFO - 2015-11-24 03:39:35,999 DEBUG : BROWSER_OUTPUT: |5;Earley;779.423226812159 03:39:36 INFO - 2015-11-24 03:39:35,999 DEBUG : BROWSER_OUTPUT: |6;Boyer;12317.073170731708 03:39:36 INFO - 2015-11-24 03:39:35,999 DEBUG : BROWSER_OUTPUT: |7;RegExp;25820.51282051282 03:39:36 INFO - 2015-11-24 03:39:35,999 DEBUG : BROWSER_OUTPUT: |8;Splay;633.3122229259025 03:39:36 INFO - 2015-11-24 03:39:36,000 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4840.579710144928 03:39:36 INFO - 2015-11-24 03:39:36,000 DEBUG : BROWSER_OUTPUT: __end_tp_report 03:39:36 INFO - 2015-11-24 03:39:36,000 DEBUG : BROWSER_OUTPUT: __startTimestamp1448365175997__endTimestamp 03:39:36 INFO - 2015-11-24 03:39:36,000 DEBUG : BROWSER_OUTPUT: 03:39:36 INFO - 2015-11-24 03:39:36,000 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 03:39:36 INFO - 2015-11-24 03:39:36,001 DEBUG : BROWSER_OUTPUT: Number of tests: 10 03:39:36 INFO - 2015-11-24 03:39:36,001 DEBUG : BROWSER_OUTPUT: 03:39:36 INFO - 2015-11-24 03:39:36,001 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:190.73 Median:190.73 stddev:0.00 (0.0%) 03:39:36 INFO - 2015-11-24 03:39:36,001 DEBUG : BROWSER_OUTPUT: Values: 190.7 03:39:36 INFO - 2015-11-24 03:39:36,001 DEBUG : BROWSER_OUTPUT: 03:39:36 INFO - 2015-11-24 03:39:36,002 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:194.55 Median:194.55 stddev:0.00 (0.0%) 03:39:36 INFO - 2015-11-24 03:39:36,002 DEBUG : BROWSER_OUTPUT: Values: 194.6 03:39:36 INFO - 2015-11-24 03:39:36,002 DEBUG : BROWSER_OUTPUT: 03:39:36 INFO - 2015-11-24 03:39:36,003 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:286.45 Median:286.45 stddev:0.00 (0.0%) 03:39:36 INFO - 2015-11-24 03:39:36,003 DEBUG : BROWSER_OUTPUT: Values: 286.5 03:39:36 INFO - 2015-11-24 03:39:36,003 DEBUG : BROWSER_OUTPUT: 03:39:36 INFO - 2015-11-24 03:39:36,004 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5010.00 Median:5010.00 stddev:0.00 (0.0%) 03:39:36 INFO - 2015-11-24 03:39:36,004 DEBUG : BROWSER_OUTPUT: Values: 5010.0 03:39:36 INFO - 2015-11-24 03:39:36,004 DEBUG : BROWSER_OUTPUT: 03:39:36 INFO - 2015-11-24 03:39:36,004 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1101.21 Median:1101.21 stddev:0.00 (0.0%) 03:39:36 INFO - 2015-11-24 03:39:36,004 DEBUG : BROWSER_OUTPUT: Values: 1101.2 03:39:36 INFO - 2015-11-24 03:39:36,004 DEBUG : BROWSER_OUTPUT: 03:39:36 INFO - 2015-11-24 03:39:36,005 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:779.42 Median:779.42 stddev:0.00 (0.0%) 03:39:36 INFO - 2015-11-24 03:39:36,005 DEBUG : BROWSER_OUTPUT: Values: 779.4 03:39:36 INFO - 2015-11-24 03:39:36,005 DEBUG : BROWSER_OUTPUT: 03:39:36 INFO - 2015-11-24 03:39:36,005 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:12317.07 Median:12317.07 stddev:0.00 (0.0%) 03:39:36 INFO - 2015-11-24 03:39:36,005 DEBUG : BROWSER_OUTPUT: Values: 12317.1 03:39:36 INFO - 2015-11-24 03:39:36,005 DEBUG : BROWSER_OUTPUT: 03:39:36 INFO - 2015-11-24 03:39:36,005 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:25820.51 Median:25820.51 stddev:0.00 (0.0%) 03:39:36 INFO - 2015-11-24 03:39:36,005 DEBUG : BROWSER_OUTPUT: Values: 25820.5 03:39:36 INFO - 2015-11-24 03:39:36,005 DEBUG : BROWSER_OUTPUT: 03:39:36 INFO - 2015-11-24 03:39:36,006 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:633.31 Median:633.31 stddev:0.00 (0.0%) 03:39:36 INFO - 2015-11-24 03:39:36,006 DEBUG : BROWSER_OUTPUT: Values: 633.3 03:39:36 INFO - 2015-11-24 03:39:36,006 DEBUG : BROWSER_OUTPUT: 03:39:36 INFO - 2015-11-24 03:39:36,006 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4840.58 Median:4840.58 stddev:0.00 (0.0%) 03:39:36 INFO - 2015-11-24 03:39:36,006 DEBUG : BROWSER_OUTPUT: Values: 4840.6 03:39:36 INFO - 2015-11-24 03:39:36,006 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 03:39:36 INFO - 2015-11-24 03:39:36,006 DEBUG : BROWSER_OUTPUT: 03:39:36 INFO - 2015-11-24 03:39:36,881 INFO : Browser exited with error code: 0 03:39:36 INFO - 2015-11-24 03:39:36,896 INFO : Completed test v8_7 (00:00:39) 03:39:36 INFO - 2015-11-24 03:39:36,976 INFO : Completed test suite (00:20:11) 03:39:36 INFO - 2015-11-24 03:39:36,977 DEBUG : Working with test: dromaeo_css 03:39:36 INFO - 2015-11-24 03:39:36,977 DEBUG : Generating results file: dromaeo_css 03:39:36 INFO - 2015-11-24 03:39:36,978 DEBUG : Working with test: kraken 03:39:36 INFO - 2015-11-24 03:39:36,978 DEBUG : Generating results file: kraken 03:39:36 INFO - 2015-11-24 03:39:36,979 INFO : javascript benchmark 03:39:36 INFO - 2015-11-24 03:39:36,979 DEBUG : Working with test: v8_7 03:39:36 INFO - 2015-11-24 03:39:36,979 DEBUG : Generating results file: v8_7 03:39:36 INFO - 2015-11-24 03:39:36,980 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 03:39:37 INFO - 2015-11-24 03:39:37,048 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,64,35]] 03:39:37 INFO - 2015-11-24 03:39:37,048 DEBUG : process_Request line: dromaeo_css 6945.18 graph.html#tests=[[72,64,35]] 03:39:37 INFO - 2015-11-24 03:39:37,048 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 03:39:37 INFO - 2015-11-24 03:39:37,079 DEBUG : process_Request line: kraken 1501.00 graph.html#tests=[[232,64,35]] 03:39:37 INFO - 2015-11-24 03:39:37,079 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 03:39:37 INFO - 2015-11-24 03:39:37,111 DEBUG : process_Request line: v8_7 20632.57 graph.html#tests=[[230,64,35]] 03:39:37 INFO - 2015-11-24 03:39:37,113 INFO : javascript benchmark 03:39:37 INFO - 2015-11-24 03:39:37,117 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3199.6800319967997, 3291.6050073991123, 3324.401607710611, 3324.700776930077, 3340.532325474434, 5281.339832520935, 5377.327834020747, 5452.67283962962, 5490.780368785248, 5542.057850165472, 5420.214068959998, 5426.375966763823, 5479.753411096501, 5479.972600136994, 5546.889062218764, 5005.5244751748705, 5012.9749351253195, 5025.1708468102715, 5037.672551284173, 5093.898122037557, 4895.926561101586, 5030.270610761438, 5050.747462626872, 5107.923381149286, 5140.434552199255, 4899.632527560448, 5017.473165317644, 5023.497650234947, 5025.623078269145, 5054.267131265982, 4988.326575912278, 4990.65065445419, 4991.151504244287, 4994.200927851526, 5039.244113382985, 4840.636952228597, 4970.82602108928, 4975.179095449246, 4985.1774457214515, 5036.294918711384, 5174.6636468629795, 5184.455632158644, 5257.658252213594, 5274.973625131888, 5303.310569625924, 5985.4912332451795, 6008.639481631116, 6011.909821352683, 6017.217761690996, 6020.939790602126, 5587.469190426903, 5706.971465142689, 6010.218671572711, 6020.638761674313, 6030.276366836008, 5417.024935511607, 5480.945190548123, 5519.0, 5527.723613819293, 5540.584456165723, 5902.966980778347, 5906.763729450774, 5920.111983202554, 5923.407659234128, 5937.228160339215, 5682.914756278659, 5727.942720572824, 5754.309482862083, 5756.827295181151, 5822.214001109796, 5764.510016648548, 5822.301323841166, 5866.325372582122, 5911.586188966731, 5965.254343207099, 5806.21616081832, 5875.676837773964, 5889.705514724246, 5893.970530147321, 5896.115582662549, 5660.462256085665, 5867.61860479076, 5880.705964701748, 5895.233619629421, 5903.0, 4499.437570303712, 4534.183846907522, 4547.204239258117, 4550.47669518003, 4578.153041687232, 4065.6340929316502, 4084.326086195804, 4088.202800453883, 4090.3864420337186, 4128.91742165161, 5333.200019997032, 5651.491365777099, 5664.830055098354, 5667.518260947865, 5670.206171136044, 5729.512991395694, 5776.133579962955, 5817.592768506249, 5861.20873682056, 5886.087656413263, 5595.804146854841, 5674.1488776683, 5681.375048744635, 5687.914681279784, 5688.857778555569, 4979.701217926863, 5190.896182076337, 5202.947970520322, 5213.0, 5262.263283140287, 6028.095785632103, 6050.273967123885, 6117.583823141572, 6125.384584648569, 6126.088324766622, 5886.6173698709445, 5970.820875373745, 5973.223480947623, 5975.940240597538, 5978.252718410199, 5772.393898640582, 5885.470307672159, 6143.6928153593035, 6158.168647232566, 6166.876662466815, 5780.624259423124, 5789.8552536186935, 5880.617759845596, 5882.735276912635, 5934.881302374015, 5893.381194974466, 5915.852103697442, 5916.822495325147, 5919.348871624032, 5924.674142922181, 5628.662280263197, 5742.397048309867, 5791.710414479175, 5792.073268277056, 5805.82582522525, 5656.490915817596, 5691.686957217227, 5715.485606295453, 5716.571257155647, 5718.742656580381, 5568.665880047048, 5569.387367389503, 5570.997220500349, 5574.693391863487, 5574.9721251393485, 5627.606067575394, 5671.149327600893, 5707.543396528351, 5736.196932429547, 5816.621919575214, 5714.514266287412, 5720.199172115824, 5723.055695810144, 5723.198752174616, 5764.365919748908], "unit": "ms", "name": "dojo.html", "value": 5425.1938601526945}, {"lowerIsBetter": false, "replicates": [537.0982101591349, 596.7135774828082, 596.9403059694031, 599.5623195067603, 602.861341891365, 30807.22981925453, 32080.03759887201, 40361.39457908134, 40863.182736345254, 40887.79556102223, 42762.786186069025, 43167.136657266834, 43228.13543729123, 43325.783371083104, 43330.0, 7756.224377562255, 8774.254188393994, 8926.598303076376, 8936.240419564345, 8949.149830766068, 7742.187070357616, 7837.960810195941, 10523.789524209511, 10795.78408431831, 10797.244192906499, 10474.58101675932, 10557.524911379007, 10565.260431769779, 10567.78864422711, 10577.73555661107, 7857.371410287164, 8037.316828069621, 10361.585536578528, 10361.740956476111, 10427.0, 7731.845363092707, 7839.608019599054, 7842.176571460029, 10563.894361056446, 10871.891281087246, 39151.216975660325, 39425.802870985746, 39626.60373396258, 39628.40557391642, 39631.603683963076, 3300.752443566742, 3331.2338162222823, 3364.310316385135, 3637.254362855608, 4050.210209009215, 29619.851900740574, 29689.851550742107, 29842.40315193706, 30361.69638303611, 30895.227619309473, 3791.374423220165, 3919.6668283195963, 3964.861229856941, 4030.2745505808944, 4130.3937820748115, 260598.0, 262447.6877615619, 262540.0, 262717.0, 262868.0, 57481.425185747605, 57670.7116464415, 57914.420855791745, 57929.4207057924, 58054.0, 54001.72999134979, 55620.27227685692, 61973.0, 62240.0, 62247.688761556805, 13923.930380348034, 14323.85676143246, 14327.641808954859, 16404.835951640332, 16806.32774689023, 11377.0, 11459.19785614999, 11537.0, 11545.942270288762, 11569.88430115705, 16462.588435288973, 19428.125734341706, 19452.416427507196, 19551.804481954998, 19594.227732586824, 6637.3030831762935, 7552.8867066994035, 7658.157602663702, 7668.271514206142, 7694.769156925301, 949.4777872170279, 965.3435663748718, 976.3848775271533, 1029.3052189771875, 1130.5251794246435, 26460.0, 27308.0, 27539.0, 27591.86204068967, 27821.860890695418, 1000.2648053680539, 1011.1051719228535, 1016.065219997604, 1091.6888686724403, 1127.9548818047185, 14404.423823047171, 14528.782068268985, 14613.196274204809, 14696.412143514353, 14833.92583037078, 289582.0, 292136.0, 292361.0, 292593.0, 293492.0, 52599.737001315516, 52692.473075269525, 53103.0, 53192.0, 53220.73389633027, 1302.811092391617, 1354.2348573056388, 1374.3265799758046, 1377.366411450744, 1383.5088543567292, 26589.33526661849, 26815.865920670272, 27418.115790209165, 27676.861615691792, 27745.722542774314, 43708.34437483504, 44317.0, 44830.77584612056, 45419.772901135286, 45517.54482455133, 279980.0, 285931.0, 286877.0, 287357.0, 288039.0, 30145.698543015165, 30604.84697576498, 30610.387792244477, 30617.23456913595, 30661.0, 39341.40987885241, 40334.19331613293, 40777.796111019255, 41274.38088428616, 41417.58582414258, 36092.0, 36841.0, 36965.44551831671, 37018.444723328634, 40213.39679904862, 35269.47095793514, 35999.0, 36062.557497699796, 36506.452403214505, 36582.26835463222, 35339.46990795089, 36365.0908727284, 36741.63258367489, 36754.8162259187, 36760.81619591992, 30944.0, 31748.68251317457, 33063.669363307024, 33482.66517334795, 33550.66449335475, 25309.240722778348, 25505.48989020246, 25717.0, 25746.613800792627, 25867.741322587288], "unit": "ms", "name": "ext.html", "value": 18481.95036380943}, {"lowerIsBetter": false, "replicates": [351.17649112830406, 353.0995960301232, 354.50723494342867, 355.58041511017024, 359.84706499737604, 14272.215028173447, 14764.04033737809, 15983.76024359634, 16488.91755541222, 17199.226034828433, 16354.754678679828, 16972.915135424304, 16987.74518382225, 17470.039147846863, 17499.475015749515, 5261.921071183926, 5427.402985671573, 5427.891442171154, 5430.0, 5431.701256430894, 4111.36273877548, 4260.0414906646065, 5405.216243644669, 5947.791827286046, 6108.969455152718, 5884.941150588504, 5998.52011839054, 6015.669138197398, 6046.606970546923, 6047.304559975593, 6088.056351265561, 6093.939060609404, 6149.169862068608, 6164.630122192638, 6169.321374648785, 5232.686038837682, 5315.734213289359, 5352.464753524655, 5366.8926621467745, 5371.301730775013, 21343.35969920905, 21537.246196383207, 21715.674264886038, 21783.34649960504, 21971.34085977423, 2203.5262418579923, 2213.9889300553555, 2281.3042022183226, 2321.4776675248104, 2345.5660702769874, 13391.464341426332, 13570.185788852601, 13631.863681363258, 13990.650233744136, 14172.787408188886, 1764.1003088424868, 1837.3844762004744, 1856.693645548483, 1869.3457289948544, 1893.5266183454137, 59988.700056499874, 63069.369306306806, 63637.68181159064, 64333.3566664332, 65665.01502477466, 9466.432014079177, 9522.047795220422, 9717.854232186522, 10074.244431667654, 10117.342372745896, 13032.934835325763, 13113.737725245443, 13208.141470804367, 13248.933755331162, 13250.072494925264, 7558.281963213486, 7612.1246056703085, 7616.857471379338, 7682.193369696213, 7695.268949449794, 7327.047483827068, 7386.519876208029, 7386.556806591621, 7453.2546745325035, 7456.627168641547, 5579.2746942897165, 6024.0662697282, 6092.908606370908, 6115.205023347025, 6126.632402055891, 1662.7339625659836, 1729.5676080979756, 1750.1249375312343, 1768.849647779953, 1778.199810085441, 388.92610404023145, 399.2354640862773, 399.9580044095328, 411.8187997281187, 1002.3134153105146, 10412.947935260276, 10550.261481696361, 10950.178736594627, 11049.944750276198, 11069.5018724156, 431.7733190075236, 431.8920269932517, 435.18185810675726, 458.9311603259538, 467.483430808958, 9736.805263894825, 9920.454375009444, 10142.746431339128, 10249.590016399261, 10374.740631484274, 471087.0, 476219.0, 501952.0, 532236.0, 532448.0, 80243.0, 81827.59086204531, 81854.59072704599, 82314.58842705868, 82535.0, 1142.6973250494443, 1155.838182654446, 1161.9070474362031, 1165.4988355007258, 1165.516310731037, 12889.548865789653, 15248.0, 15370.154641494824, 15843.920780396023, 15857.682846342777, 33523.329533409684, 33634.32731345409, 33822.0, 34434.82782586071, 34562.654373455945, 49807.0, 50985.23522147245, 51800.222996654324, 52449.0, 52641.47358526366, 9429.952850235704, 9603.951980240054, 9627.326087173831, 9727.0, 9752.756181095529, 11306.83039754388, 11340.0, 11352.489137988976, 11406.315621062762, 12911.741765164832, 14855.92572037133, 14885.851141488447, 15112.773308400603, 15205.391784328503, 15231.77484158542, 13892.513762018281, 14407.0, 14471.927640361731, 14808.851911480748, 15109.244537772847, 14545.41818327255, 14796.704065918406, 14910.105393676415, 15180.544583662508, 15258.160801156044, 9049.457032578066, 9133.132352426508, 9299.209567186594, 9477.431354118775, 9502.47736374506, 9579.760505987128, 10387.532561034923, 14497.565073047825, 15155.848441515443, 15287.0], "unit": "ms", "name": "jquery.html", "value": 8601.474508405285}, {"lowerIsBetter": false, "replicates": [1325.337331334333, 1457.1184433417782, 1479.58571599952, 1634.9346026158955, 1783.3223375117445, 6511.576747511414, 7668.309852113309, 7847.489913155641, 7852.136265010844, 7853.0, 7635.541867487955, 7776.650050747716, 7782.805429864256, 7783.571903545303, 7797.6491057902385, 1936.6707659697815, 1965.0174912543728, 1966.9409917702492, 2216.1910902520544, 2238.563480121377, 2213.7122174117344, 2240.047979608668, 2244.1360076370634, 2245.404967683557, 2245.5059886824874, 2179.705739725133, 2202.2622421488823, 2208.0615738311153, 2241.8430709850318, 2247.898844551999, 1952.7363805886237, 1987.4435158155595, 2128.9254876079262, 2199.7800219977953, 2229.308914236584, 2225.6661500775012, 2235.1841577823975, 2235.798778109978, 2236.2955668964223, 2238.6082435573708, 7573.356264717506, 7591.620418979029, 7591.962040189764, 7625.923740762577, 7628.122765881939, 4591.954080459186, 4644.512326205768, 4658.95341046592, 4660.184467718136, 4687.343771871941, 2948.9262768430963, 2967.406518696248, 3036.7266945974748, 3055.724984751361, 3068.3709839482854, 959.4147569982305, 962.9374090684153, 997.3417544420647, 1022.9488525573692, 1038.709161434792, 10788.622398216103, 10823.891761082366, 10844.0, 10844.668396294834, 10875.891241087646, 4160.563140870226, 4202.054537728986, 4251.0010147615285, 4253.3194688849635, 4283.764392958355, 9283.767905802273, 9286.396384235139, 9302.441853488812, 9314.627414903329, 9316.720498384924, 4746.549077837669, 4773.427188737304, 4785.808567657325, 4786.018866132504, 4787.257975013808, 4263.445752052214, 4282.700210985264, 4298.742075475481, 4327.2643650579475, 4340.631046361094, 3687.3362794697214, 3691.593924668284, 3705.7961812100593, 3734.4398340248636, 3744.344739670547, 1154.3362566524281, 1154.5612667186583, 1157.0512180012477, 1196.1925700152362, 1205.3491114797912, 1303.9348032598332, 1307.078509650694, 1336.5856584458654, 1349.8515163332027, 1350.8108864758942, 7354.521956072838, 7425.517341372793, 7459.738909138154, 7462.029936108272, 7492.288232617892, 457.13601293555206, 462.51204978747745, 467.7661169415292, 468.03584615691784, 471.86080106368706, 5303.310569626001, 5447.863803404946, 6120.816375508742, 6189.473894718909, 6300.936990630035, 8684.2184203422, 8859.51272679996, 8911.465312081296, 9239.39943903644, 9242.445453272825, 9261.490618016074, 9276.814463710689, 9395.436273823592, 9418.0, 9421.576029078708, 7140.821479462951, 7163.7134514619875, 7180.676869540779, 7312.1591017033725, 7350.595717235603, 7367.0, 7374.410047196104, 7381.667824947997, 7418.777436676908, 7427.331540161412, 8002.919970800217, 8251.917480825115, 8392.706255281037, 8395.454295470774, 8415.663373464993, 8218.958905205436, 8287.12985136576, 8341.582920853813, 8395.622197001028, 8503.532305723245, 7373.262673732584, 7406.8148296290865, 7440.590767507839, 7457.067866516685, 7491.737789177353, 7520.811979700551, 7623.847523049619, 7625.428092892944, 7627.466077374531, 7629.465937384552, 6959.512834101564, 7202.819929501804, 7207.423406127602, 7326.0, 7347.889781653173, 6870.896936546056, 6969.16370035599, 7021.0, 7093.787186384417, 7215.025971493781, 7011.789646310619, 7062.329078737512, 7096.645167741695, 7096.645167741695, 7099.325564071405, 6363.681815909279, 6433.517486188461, 6443.420092191725, 6447.129637499065, 6458.806235812933, 5490.203920431595, 5632.662040277596, 6411.839704007437, 6420.229572451336, 6535.869282614226], "unit": "ms", "name": "mootools.html", "value": 4373.4766421937675}, {"lowerIsBetter": false, "replicates": [319.4202522421805, 321.9002109346103, 324.47921086655924, 326.48089537635155, 326.7924867709004, 5864.09106588479, 5951.910721339178, 5958.612690175147, 5973.940260597393, 5982.670953097578, 5582.748776305066, 5708.514776244025, 5721.084626459757, 5886.087656413263, 5886.440788125121, 4557.840475583355, 4570.7257564546235, 4582.19811532982, 4583.587477127058, 4591.449026116862, 4318.157959197958, 4570.611498022672, 4572.702774319659, 4575.130725162225, 4585.9541404586025, 4345.543717909622, 4393.319035549495, 4532.320151977214, 4551.658625603093, 4555.476120246181, 4506.1663592235545, 4507.977460112678, 4511.72929624222, 4523.570260825217, 4524.434445694288, 3961.0889495415927, 3967.3453880109746, 3982.2433737589763, 3985.4221137934837, 3986.5216174059296, 5511.311086114236, 5612.382637909826, 5614.775408983635, 5619.381867994517, 5628.774849006035, 5276.366835979707, 5281.551068159211, 5287.788488460457, 5295.205719142121, 5296.576273898079, 6266.561340706153, 6279.120923070774, 6279.654618995954, 6280.654563998978, 6282.717277722513, 4417.469903611555, 4419.955800441987, 4423.845165419227, 4424.02671412292, 4428.955710442887, 6343.936560634381, 6503.544751867371, 6503.869922601569, 6508.64202468864, 6515.283318834924, 4517.819287228474, 4519.389882365838, 4520.118576877543, 4520.773961301922, 4520.81916723334, 4573.702709323883, 4574.428196475441, 4580.908381832344, 4582.633389328846, 4586.610138138296, 5267.394249661338, 5273.6572122811895, 5275.182346736262, 5278.577713782888, 5284.39229488606, 6237.750489980441, 6310.242770867525, 6339.461145802658, 6348.333424990402, 6401.391867772554, 1609.1793185475258, 1632.0370981121196, 1633.681432120725, 1633.918304084791, 1634.3135882929198, 1100.9009189173014, 1105.5633024955098, 1106.8616422947132, 1112.6884472347756, 1129.768397478515, 6138.877222455526, 6155.230596175478, 6156.969215153896, 6158.199434073542, 6160.876782464416, 6530.477561795045, 6544.607323560602, 6548.312427195171, 6559.409653131241, 6566.967165164144, 5991.221141251696, 5998.0, 6120.755169793248, 6210.534209934273, 6216.316205217422, 3547.255076433926, 3573.0, 3583.211693427442, 3584.874529391459, 3587.6232995535615, 6528.21661400635, 6707.362800534039, 6800.591964482147, 6805.591664500146, 6814.386705196556, 6554.442872355903, 6726.596404215763, 6727.159105111861, 6770.018347339608, 6792.660366981631, 6715.529912906148, 6723.798286051427, 6748.662566871637, 6755.864882702318, 6756.966215168893, 6455.61266324022, 6583.703733331916, 6597.736090556324, 6606.636634985122, 6606.735730570916, 6506.60960342381, 6528.608283503005, 6529.640869752209, 6531.3468653134305, 6535.477161826947, 6790.898136528055, 6801.081853949653, 6804.727810887509, 6809.625470599165, 6815.488838337244, 4448.154850578379, 4469.44131983502, 4485.955140448685, 4546.977265113654, 4552.635789136795, 6553.279139294769, 6553.344665533408, 6556.213254409311, 6559.311272316529, 6565.179352580927, 6405.3594640535575, 6412.0, 6418.229812422539, 6423.389777971085, 6423.775167869102, 6274.245902937153, 6356.618602883842, 6396.264429590657, 6400.45596124316, 6400.807975760735, 6271.3728627136925, 6276.121343012073, 6280.560360774884, 6287.088372186099, 6289.685515724287, 6412.262589802046, 6432.163818703539, 6434.163558737334, 6438.645874476949, 6439.839004024937, 6139.754409823736, 6254.906176407267, 6269.5611307208055, 6269.655168965751, 6277.027060805583], "unit": "ms", "name": "prototype.html", "value": 4782.150554633286}, {"lowerIsBetter": false, "replicates": [704.4364508393287, 726.7638017644267, 735.8969744235807, 813.6460639621765, 851.5912362066206, 13300.600981970532, 13723.382447789849, 13780.242086685228, 13780.448782048707, 13818.032737708365, 11994.16040877139, 12062.215955962856, 12073.818892716594, 12083.0, 12083.818742718866, 667.2560095493538, 673.3603077076772, 806.0931452116369, 806.1374329467473, 822.284612387224, 814.4543156085437, 821.0721884270765, 825.5995842016617, 826.669332267095, 829.1045670675686, 855.8202777416719, 859.1709000814213, 868.7480630617146, 870.1689886158704, 870.5690683111868, 690.837653151509, 698.6786078403941, 846.2341580869293, 859.3941271403645, 863.3007264116023, 633.8003528888386, 637.7002808679913, 640.9070684750685, 641.0320416171568, 641.3906788550895, 12552.435140418704, 12713.110082294243, 12759.744805103846, 12761.17052391601, 12774.936125319315, 11816.29102253859, 12077.516899324017, 12252.387380630933, 12394.938025309906, 12552.937235313857, 10138.594456221743, 10169.237307201916, 10169.288149829516, 10174.186065114847, 10199.0820826126, 3399.1332210286464, 3448.4310088835314, 3454.240067185215, 3496.5629296337956, 3569.250457403948, 47842.0, 48137.51862481365, 48225.27662085072, 48315.75842120802, 48420.75789621065, 9580.952095239618, 9776.608935642636, 9783.257702412184, 9927.503624818875, 9933.056359645821, 17655.205515751823, 17689.38087166943, 17690.823091768918, 17707.645847082986, 17739.911300443673, 7669.6548655309525, 7700.383969282444, 7836.412269079728, 7881.211878812073, 7896.249856263646, 4082.6937979651643, 4105.322621767435, 4107.0, 4146.315857883415, 4257.531671516131, 2924.6344206974127, 2958.3195864950753, 2961.3633068889862, 2966.5401862711315, 2971.242333205062, 521.7391304347826, 522.1723568144533, 527.0907684244647, 532.3957308454932, 539.2719828231934, 550.8292429346915, 601.9548533859978, 626.8558231606756, 655.9081728558006, 661.986760264792, 8515.19105684959, 8520.659173632985, 8615.439996400213, 8663.566821658891, 8746.825063498694, 544.2407841061776, 545.8992920213147, 693.5076095971816, 695.9060526828914, 724.7789424225662, 3960.2277555876326, 4113.814878330482, 4188.0, 4219.177260434186, 4230.915381692349, 58260.70869645625, 58262.0, 58467.122993155135, 58584.70707646434, 58916.70541647264, 47020.764896175984, 47068.7646561765, 47189.29216061762, 47734.28398574024, 47827.0, 44948.0, 46045.079098418515, 46395.30407043897, 46398.76800615976, 47093.5290647096, 8451.704190353308, 8504.829903402022, 8746.30029597618, 8810.295176385745, 8843.46939183651, 33174.0, 34014.65985340115, 34474.31051378908, 34486.13784655404, 34890.65109348874, 45395.54604454045, 45902.770486147354, 46601.407831059136, 47258.0, 47288.527114728415, 10805.621803237163, 10828.0, 10852.782944340912, 11180.217384782987, 11373.772524549628, 12261.495151704808, 12361.258324500199, 12369.62891113268, 12496.500139994298, 12586.24482531051, 10813.956380095062, 11049.28179668319, 11559.479823407799, 11641.952224299854, 11966.70083247891, 11351.432428378383, 11456.599019034295, 11497.827532587185, 11628.360440175871, 12073.39633018328, 8051.959740201261, 10488.0, 11437.42812859337, 11479.0, 11717.32697230861, 10047.0, 10107.646232382125, 10252.538635761259, 10518.789624207626, 10593.629222977159, 8434.70478533273, 9375.34372593912, 9920.355176913477, 9990.000999899952, 10003.549840257352], "unit": "ms", "name": "yui.html", "value": 6221.23090927714}], "name": "dromaeo_css", "value": 6945.180198998055}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [108.0, 110.0, 105.0, 111.0, 111.0, 111.0, 99.0, 110.0, 109.0, 99.0], "unit": "ms", "name": "ai-astar", "value": 107.3}, {"lowerIsBetter": true, "replicates": [148.0, 126.0, 147.0, 162.0, 133.0, 157.0, 151.0, 124.0, 172.0, 125.0], "unit": "ms", "name": "audio-beat-detection", "value": 144.5}, {"lowerIsBetter": true, "replicates": [161.0, 162.0, 162.0, 160.0, 159.0, 160.0, 161.0, 163.0, 161.0, 161.0], "unit": "ms", "name": "audio-dft", "value": 161.0}, {"lowerIsBetter": true, "replicates": [73.0, 71.0, 89.0, 93.0, 71.0, 71.0, 72.0, 126.0, 102.0, 71.0], "unit": "ms", "name": "audio-fft", "value": 83.9}, {"lowerIsBetter": true, "replicates": [93.0, 93.0, 142.0, 93.0, 94.0, 93.0, 138.0, 93.0, 94.0, 141.0], "unit": "ms", "name": "audio-oscillator", "value": 107.4}, {"lowerIsBetter": true, "replicates": [109.0, 110.0, 109.0, 109.0, 110.0, 109.0, 110.0, 109.0, 110.0, 110.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 109.5}, {"lowerIsBetter": true, "replicates": [145.0, 146.0, 145.0, 145.0, 146.0, 145.0, 146.0, 146.0, 146.0, 147.0], "unit": "ms", "name": "imaging-darkroom", "value": 145.7}, {"lowerIsBetter": true, "replicates": [96.0, 95.0, 97.0, 96.0, 96.0, 96.0, 95.0, 95.0, 96.0, 96.0], "unit": "ms", "name": "imaging-desaturate", "value": 95.8}, {"lowerIsBetter": true, "replicates": [58.0, 56.0, 56.0, 56.0, 56.0, 57.0, 58.0, 56.0, 59.0, 56.0], "unit": "ms", "name": "json-parse-financial", "value": 56.8}, {"lowerIsBetter": true, "replicates": [68.0, 69.0, 69.0, 69.0, 70.0, 70.0, 70.0, 70.0, 69.0, 69.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 69.3}, {"lowerIsBetter": true, "replicates": [84.0, 84.0, 85.0, 86.0, 86.0, 93.0, 85.0, 84.0, 85.0, 93.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 86.5}, {"lowerIsBetter": true, "replicates": [117.0, 123.0, 131.0, 112.0, 123.0, 116.0, 123.0, 123.0, 122.0, 119.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 120.9}, {"lowerIsBetter": true, "replicates": [138.0, 149.0, 149.0, 149.0, 148.0, 137.0, 149.0, 149.0, 147.0, 139.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 145.4}, {"lowerIsBetter": true, "replicates": [68.0, 68.0, 66.0, 66.0, 67.0, 66.0, 67.0, 68.0, 67.0, 67.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 67.0}], "name": "kraken", "value": 1501.0}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [190.7304978065993], "unit": "score", "name": "Richards", "value": 185.08838599999999}, {"lowerIsBetter": false, "replicates": [194.55252918287937], "unit": "score", "name": "DeltaBlue", "value": 339.84651999999994}, {"lowerIsBetter": false, "replicates": [286.4508736751647], "unit": "score", "name": "Encrypt", "value": 929.2378710000004}, {"lowerIsBetter": false, "replicates": [5010.0], "unit": "score", "name": "Decrypt", "value": 53.12994011976049}, {"lowerIsBetter": false, "replicates": [1101.2101210121011], "unit": "score", "name": "RayTrace", "value": 671.9780229770229}, {"lowerIsBetter": false, "replicates": [779.423226812159], "unit": "score", "name": "Earley", "value": 855.072029}, {"lowerIsBetter": false, "replicates": [12317.073170731708], "unit": "score", "name": "Boyer", "value": 54.108877227722786}, {"lowerIsBetter": false, "replicates": [25820.51282051282], "unit": "score", "name": "RegExp", "value": 35.28144488579943}, {"lowerIsBetter": false, "replicates": [633.3122229259025], "unit": "score", "name": "Splay", "value": 128.674289}, {"lowerIsBetter": false, "replicates": [4840.579710144928], "unit": "score", "name": "NavierStokes", "value": 306.5748502994012}], "name": "v8_7", "value": 20632.57150662467}]} 03:39:37 INFO - RETURN: dromaeo_css: 6945.18 03:39:37 INFO - RETURN: kraken: 1501.00 03:39:37 INFO - RETURN: v8_7: 20632.57 03:39:37 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,64,35]]", "result": "20632.57"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,35]]", "result": "1501.00"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,35]]", "result": "6945.18"}}} 03:39:37 INFO - Return code: 0 03:39:37 INFO - # TBPL SUCCESS # 03:39:37 INFO - Running post-action listener: _resource_record_post_action 03:39:37 INFO - Running post-run listener: _resource_record_post_run 03:39:38 INFO - Total resource usage - Wall time: 1227s; CPU: 13.0%; Read bytes: 4096; Write bytes: 510148608; Read time: 28; Write time: 475212 03:39:38 INFO - install - Wall time: 15s; CPU: 14.0%; Read bytes: 0; Write bytes: 243531776; Read time: 0; Write time: 311648 03:39:38 INFO - run-tests - Wall time: 1212s; CPU: 13.0%; Read bytes: 0; Write bytes: 261967872; Read time: 0; Write time: 162812 03:39:38 INFO - Running post-run listener: _upload_blobber_files 03:39:38 INFO - Blob upload gear active. 03:39:38 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 03:39:38 INFO - Copying logs to upload dir... 03:39:38 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1259.363789 ========= master_lag: 84.88 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 22 mins, 24 secs) (at 2015-11-24 03:41:03.043842) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-24 03:41:03.051623) ========= 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=61fa6ed41387771909ec0f71000001b3-1448361288.653835-2030861842 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/E06hassIRkqzMBinPtTc3g/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.009943 build_url: 'https://queue.taskcluster.net/v1/task/E06hassIRkqzMBinPtTc3g/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2' ========= master_lag: 0.48 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-24 03:41:03.542826) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-24 03:41:03.543381) ========= 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=61fa6ed41387771909ec0f71000001b3-1448361288.653835-2030861842 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004537 ========= master_lag: 0.02 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-24 03:41:03.564481) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-24 03:41:03.564941) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-24 03:41:03.565362) ========= ========= Total master_lag: 85.51 =========