builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-033 starttime: 1448408497.86 results: success (0) buildid: 20151124143004 builduid: b9ff8266b246414bb02ed846846d3dd8 revision: 8a3e98127ebc28fcc01d27bdedb4c959a456c47d ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-11-24 15:41:37.859082) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-11-24 15:41:37.859521) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-24 15:41:37.859868) ========= 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=a194aa7faa1be204aaca7d660000020b-1448405851.977553-1733921095 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006765 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-24 15:41:37.888904) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-24 15:41:37.893352) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-24 15:41:37.919186) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-24 15:41:37.919478) ========= 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=a194aa7faa1be204aaca7d660000020b-1448405851.977553-1733921095 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004632 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-24 15:41:37.977278) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-24 15:41:37.977561) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-24 15:41:37.977918) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-24 15:41:37.981281) ========= 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=a194aa7faa1be204aaca7d660000020b-1448405851.977553-1733921095 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-11-24 15:41: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% 221M=0s 2015-11-24 15:41:38 (221 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.201381 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-24 15:41:38.194604) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-24 15:41:38.198031) ========= 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=a194aa7faa1be204aaca7d660000020b-1448405851.977553-1733921095 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020379 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-24 15:41:38.253605) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-24 15:41:38.254034) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 8a3e98127ebc28fcc01d27bdedb4c959a456c47d --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 8a3e98127ebc28fcc01d27bdedb4c959a456c47d --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=a194aa7faa1be204aaca7d660000020b-1448405851.977553-1733921095 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-11-24 15:41:38,434 truncating revision to first 12 chars 2015-11-24 15:41:38,434 Setting DEBUG logging. 2015-11-24 15:41:38,434 attempt 1/10 2015-11-24 15:41:38,434 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/8a3e98127ebc?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-11-24 15:41:38,662 unpacking tar archive at: fx-team-8a3e98127ebc/testing/mozharness/ program finished with exit code 0 elapsedTime=0.495687 ========= master_lag: 0.04 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-24 15:41:38.786950) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-24 15:41:38.790371) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-24 15:41:38.802969) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-24 15:41:38.803355) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-24 15:41:38.803788) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 17 secs) (at 2015-11-24 15:41:38.804100) ========= /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=a194aa7faa1be204aaca7d660000020b-1448405851.977553-1733921095 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 15:41:39 INFO - MultiFileLogger online at 20151124 15:41:39 in /builds/slave/test-pgo 15:41: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 15:41:39 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 15:41:39 INFO - {'append_to_log': False, 15:41:39 INFO - 'base_work_dir': '/builds/slave/test-pgo', 15:41:39 INFO - 'blob_upload_branch': 'Fx-Team', 15:41:39 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 15:41:39 INFO - 'branch': 'Fx-Team', 15:41:39 INFO - 'buildbot_json_path': 'buildprops.json', 15:41:39 INFO - 'config_files': ('talos/linux_config.py',), 15:41:39 INFO - 'default_actions': ('clobber', 15:41:39 INFO - 'read-buildbot-config', 15:41:39 INFO - 'download-and-extract', 15:41:39 INFO - 'populate-webroot', 15:41:39 INFO - 'create-virtualenv', 15:41:39 INFO - 'install', 15:41:39 INFO - 'run-tests'), 15:41:39 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 15:41:39 INFO - 'download_minidump_stackwalk': True, 15:41:39 INFO - 'download_symbols': 'ondemand', 15:41:39 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 15:41:39 INFO - 'tooltool.py': '/tools/tooltool.py', 15:41:39 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 15:41:39 INFO - '/tools/misc-python/virtualenv.py')}, 15:41:39 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 15:41:39 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 15:41:39 INFO - 'installer_path': 'installer.exe', 15:41:39 INFO - 'log_level': 'info', 15:41:39 INFO - 'log_name': 'talos', 15:41:39 INFO - 'log_to_console': True, 15:41:39 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 15:41:39 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 15:41:39 INFO - 'opt_config_files': (), 15:41:39 INFO - 'pip_index': False, 15:41:39 INFO - 'sps_profile': False, 15:41:39 INFO - 'sps_profile_interval': 0, 15:41:39 INFO - 'suite': 'dromaeojs', 15:41:39 INFO - 'system_bits': '64', 15:41:39 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 15:41:39 INFO - 'title': 'talos-linux64-ix-033', 15:41:39 INFO - 'tooltool_cache': '/builds/tooltool_cache', 15:41:39 INFO - 'use_talos_json': True, 15:41:39 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 15:41:39 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 15:41:39 INFO - 'work_dir': 'build'} 15:41:39 INFO - ##### 15:41:39 INFO - ##### Running clobber step. 15:41:39 INFO - ##### 15:41:39 INFO - Running pre-action listener: _resource_record_pre_action 15:41:39 INFO - Running main action method: clobber 15:41:39 INFO - rmtree: /builds/slave/test-pgo/build 15:41:39 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 15:41:39 INFO - Running post-action listener: _resource_record_post_action 15:41:39 INFO - ##### 15:41:39 INFO - ##### Running read-buildbot-config step. 15:41:39 INFO - ##### 15:41:39 INFO - Running pre-action listener: _resource_record_pre_action 15:41:39 INFO - Running main action method: read_buildbot_config 15:41:39 INFO - Using buildbot properties: 15:41:39 INFO - { 15:41:39 INFO - "properties": { 15:41:39 INFO - "buildnumber": 801, 15:41:39 INFO - "product": "firefox", 15:41:39 INFO - "script_repo_revision": "production", 15:41:39 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 15:41:39 INFO - "repository": "", 15:41:39 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 15:41:39 INFO - "buildid": "20151124143004", 15:41:39 INFO - "slavename": "talos-linux64-ix-033", 15:41:39 INFO - "pgo_build": "True", 15:41:39 INFO - "basedir": "/builds/slave/test-pgo", 15:41:39 INFO - "project": "", 15:41:39 INFO - "platform": "ubuntu64_hw", 15:41:39 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 15:41:39 INFO - "slavebuilddir": "test", 15:41:39 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 15:41:39 INFO - "branch": "fx-team", 15:41:39 INFO - "repo_path": "integration/fx-team", 15:41:39 INFO - "stage_platform": "linux64-pgo", 15:41:39 INFO - "builduid": "b9ff8266b246414bb02ed846846d3dd8", 15:41:39 INFO - "revision": "8a3e98127ebc28fcc01d27bdedb4c959a456c47d" 15:41:39 INFO - }, 15:41:39 INFO - "sourcestamp": { 15:41:39 INFO - "repository": "", 15:41:39 INFO - "hasPatch": false, 15:41:39 INFO - "project": "", 15:41:39 INFO - "branch": "fx-team-linux64-pgo-talos", 15:41:39 INFO - "changes": [ 15:41:39 INFO - { 15:41:39 INFO - "category": null, 15:41:39 INFO - "files": [ 15:41:39 INFO - { 15:41:39 INFO - "url": null, 15:41:39 INFO - "name": "https://queue.taskcluster.net/v1/task/sDvUxvG9T1m4MMYOh9Qddg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2" 15:41:39 INFO - } 15:41:39 INFO - ], 15:41:39 INFO - "repository": "", 15:41:39 INFO - "rev": "8a3e98127ebc28fcc01d27bdedb4c959a456c47d", 15:41:39 INFO - "who": "sendchange", 15:41:39 INFO - "when": 1448408434, 15:41:39 INFO - "number": 6702463, 15:41:39 INFO - "comments": "", 15:41:39 INFO - "project": "", 15:41:39 INFO - "at": "Tue 24 Nov 2015 15:40:34", 15:41:39 INFO - "branch": "fx-team-linux64-pgo-talos", 15:41:39 INFO - "revlink": "", 15:41:39 INFO - "properties": [ 15:41:39 INFO - [ 15:41:39 INFO - "buildid", 15:41:39 INFO - "20151124143004", 15:41:39 INFO - "Change" 15:41:39 INFO - ], 15:41:39 INFO - [ 15:41:39 INFO - "builduid", 15:41:39 INFO - "b9ff8266b246414bb02ed846846d3dd8", 15:41:39 INFO - "Change" 15:41:39 INFO - ], 15:41:39 INFO - [ 15:41:39 INFO - "pgo_build", 15:41:39 INFO - "True", 15:41:39 INFO - "Change" 15:41:39 INFO - ] 15:41:39 INFO - ], 15:41:39 INFO - "revision": "8a3e98127ebc28fcc01d27bdedb4c959a456c47d" 15:41:39 INFO - } 15:41:39 INFO - ], 15:41:39 INFO - "revision": "8a3e98127ebc28fcc01d27bdedb4c959a456c47d" 15:41:39 INFO - } 15:41:39 INFO - } 15:41:39 INFO - Found installer url https://queue.taskcluster.net/v1/task/sDvUxvG9T1m4MMYOh9Qddg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2. 15:41:39 INFO - Running post-action listener: _resource_record_post_action 15:41:39 INFO - ##### 15:41:39 INFO - ##### Running download-and-extract step. 15:41:39 INFO - ##### 15:41:39 INFO - Running pre-action listener: _resource_record_pre_action 15:41:39 INFO - Running main action method: download_and_extract 15:41:39 INFO - mkdir: /builds/slave/test-pgo/build/tests 15:41: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')]} 15:41:39 INFO - https://queue.taskcluster.net/v1/task/sDvUxvG9T1m4MMYOh9Qddg/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 15:41:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/sDvUxvG9T1m4MMYOh9Qddg/artifacts/public/build/test_packages.json 15:41:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/sDvUxvG9T1m4MMYOh9Qddg/artifacts/public/build/test_packages.json 15:41:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/sDvUxvG9T1m4MMYOh9Qddg/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 15:41:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/sDvUxvG9T1m4MMYOh9Qddg/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 15:41:46 INFO - Downloaded 1302 bytes. 15:41:46 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 15:41:46 INFO - Using the following test package requirements: 15:41:46 INFO - {u'common': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 15:41:46 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 15:41:46 INFO - u'firefox-45.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 15:41:46 INFO - u'jittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 15:41:46 INFO - u'jsshell-linux-x86_64.zip'], 15:41:46 INFO - u'mochitest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 15:41:46 INFO - u'firefox-45.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 15:41:46 INFO - u'mozbase': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 15:41:46 INFO - u'reftest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 15:41:46 INFO - u'firefox-45.0a1.en-US.linux-x86_64.reftest.tests.zip'], 15:41:46 INFO - u'talos': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 15:41:46 INFO - u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'], 15:41:46 INFO - u'web-platform': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 15:41:46 INFO - u'firefox-45.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 15:41:46 INFO - u'webapprt': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 15:41:46 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 15:41:46 INFO - u'firefox-45.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 15:41:46 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 15:41:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:41:46 INFO - https://queue.taskcluster.net/v1/task/sDvUxvG9T1m4MMYOh9Qddg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 15:41:46 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/sDvUxvG9T1m4MMYOh9Qddg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 15:41:46 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/sDvUxvG9T1m4MMYOh9Qddg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 15:41:46 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/sDvUxvG9T1m4MMYOh9Qddg/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 15:41:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/sDvUxvG9T1m4MMYOh9Qddg/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 15:41:55 INFO - Downloaded 22526274 bytes. 15:41:55 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 15:41:55 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 15:41:55 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 15:41:56 INFO - Return code: 0 15:41:56 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 15:41: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')]} 15:41:56 INFO - https://queue.taskcluster.net/v1/task/sDvUxvG9T1m4MMYOh9Qddg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 15:41:56 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/sDvUxvG9T1m4MMYOh9Qddg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 15:41:56 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/sDvUxvG9T1m4MMYOh9Qddg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 15:41:56 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/sDvUxvG9T1m4MMYOh9Qddg/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 15:41:56 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/sDvUxvG9T1m4MMYOh9Qddg/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 15:41:59 INFO - Downloaded 22526274 bytes. 15:42:00 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 15:42:00 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 15:42:00 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 15:42:01 INFO - Return code: 0 15:42:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:42:01 INFO - https://queue.taskcluster.net/v1/task/sDvUxvG9T1m4MMYOh9Qddg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 15:42:01 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/sDvUxvG9T1m4MMYOh9Qddg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 15:42:01 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/sDvUxvG9T1m4MMYOh9Qddg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 15:42:01 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/sDvUxvG9T1m4MMYOh9Qddg/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 15:42:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/sDvUxvG9T1m4MMYOh9Qddg/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 15:42:02 INFO - Downloaded 11130997 bytes. 15:42:02 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 15:42:02 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 15:42:02 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 15:42:02 INFO - Return code: 0 15:42: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')]} 15:42:02 INFO - https://queue.taskcluster.net/v1/task/sDvUxvG9T1m4MMYOh9Qddg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 15:42:02 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/sDvUxvG9T1m4MMYOh9Qddg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 15:42:02 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/sDvUxvG9T1m4MMYOh9Qddg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 15:42:02 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/sDvUxvG9T1m4MMYOh9Qddg/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 15:42:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/sDvUxvG9T1m4MMYOh9Qddg/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 15:42:07 INFO - Downloaded 57640729 bytes. 15:42:07 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/sDvUxvG9T1m4MMYOh9Qddg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 15:42:07 INFO - mkdir: /builds/slave/test-pgo/properties 15:42:07 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 15:42:07 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 15:42:07 INFO - Contents: 15:42:07 INFO - build_url:https://queue.taskcluster.net/v1/task/sDvUxvG9T1m4MMYOh9Qddg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 15:42:07 INFO - Running post-action listener: _resource_record_post_action 15:42:07 INFO - Running post-action listener: set_extra_try_arguments 15:42:07 INFO - ##### 15:42:07 INFO - ##### Running populate-webroot step. 15:42:07 INFO - ##### 15:42:07 INFO - Running pre-action listener: _resource_record_pre_action 15:42:07 INFO - Running main action method: populate_webroot 15:42:07 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 15:42:07 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 15:42:07 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 15:42:07 INFO - '../fennec_ids.txt'], 15:42:07 INFO - 'tests': ['tcheck2']}, 15:42:07 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 15:42:07 INFO - '--tppagecycles', 15:42:07 INFO - '7'], 15:42:07 INFO - 'tests': ['tsvgm']}}, 15:42:07 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 15:42:07 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 15:42:07 INFO - 'tests': ['tresize', 'tcanvasmark']}, 15:42:07 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 15:42:07 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 15:42:07 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 15:42:07 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:42:07 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:42:07 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:42:07 INFO - 'talos_options': ['--e10s'], 15:42:07 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:42:07 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:42:07 INFO - 'tests': ['damp', 'tps']}, 15:42:07 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:42:07 INFO - 'talos_options': ['--e10s'], 15:42:07 INFO - 'tests': ['damp', 'tps']}, 15:42:07 INFO - 'g3': {'tests': ['dromaeo_dom']}, 15:42:07 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 15:42:07 INFO - 'other': {'tests': ['a11yr', 15:42:07 INFO - 'ts_paint', 15:42:07 INFO - 'tpaint', 15:42:07 INFO - 'sessionrestore', 15:42:07 INFO - 'sessionrestore_no_auto_restore']}, 15:42:07 INFO - 'other-e10s': {'talos_options': ['--e10s'], 15:42:07 INFO - 'tests': ['a11yr', 15:42:07 INFO - 'ts_paint', 15:42:07 INFO - 'tpaint', 15:42:07 INFO - 'sessionrestore', 15:42:07 INFO - 'sessionrestore_no_auto_restore']}, 15:42:07 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 15:42:07 INFO - 'tests': ['a11yr', 15:42:07 INFO - 'ts_paint', 15:42:07 INFO - 'tpaint', 15:42:07 INFO - 'sessionrestore', 15:42:07 INFO - 'sessionrestore_no_auto_restore']}, 15:42:07 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 15:42:07 INFO - 'tests': ['a11yr', 15:42:07 INFO - 'ts_paint', 15:42:07 INFO - 'tpaint', 15:42:07 INFO - 'sessionrestore', 15:42:07 INFO - 'sessionrestore_no_auto_restore']}, 15:42:07 INFO - 'other_l64': {'tests': ['a11yr', 15:42:07 INFO - 'ts_paint', 15:42:07 INFO - 'tpaint', 15:42:07 INFO - 'sessionrestore', 15:42:07 INFO - 'sessionrestore_no_auto_restore']}, 15:42:07 INFO - 'other_nol64': {'tests': ['a11yr', 15:42:07 INFO - 'ts_paint', 15:42:07 INFO - 'tpaint', 15:42:07 INFO - 'sessionrestore', 15:42:07 INFO - 'sessionrestore_no_auto_restore']}, 15:42:07 INFO - 'svgr': {'tests': ['tsvgx', 15:42:07 INFO - 'tsvgr_opacity', 15:42:07 INFO - 'tart', 15:42:07 INFO - 'tscrollx', 15:42:07 INFO - 'cart']}, 15:42:07 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 15:42:07 INFO - 'tests': ['tsvgx', 15:42:07 INFO - 'tsvgr_opacity', 15:42:07 INFO - 'tart', 15:42:07 INFO - 'tscrollx', 15:42:07 INFO - 'cart']}, 15:42:07 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:42:07 INFO - 'tests': ['tp5o']}, 15:42:07 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:42:07 INFO - 'talos_options': ['--e10s'], 15:42:07 INFO - 'tests': ['tp5o']}, 15:42:07 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:42:07 INFO - 'talos_options': ['--xperf_path', 15:42:07 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:42:07 INFO - 'tests': ['tp5n']}, 15:42:07 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:42:07 INFO - 'talos_options': ['--e10s', 15:42:07 INFO - '--xperf_path', 15:42:07 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:42:07 INFO - 'tests': ['tp5n']}}, 15:42:07 INFO - 'talos.zip': {'path': '', 15:42:07 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 15:42:07 INFO - Running post-action listener: _resource_record_post_action 15:42:07 INFO - ##### 15:42:07 INFO - ##### Running create-virtualenv step. 15:42:07 INFO - ##### 15:42:07 INFO - Running pre-action listener: _resource_record_pre_action 15:42:07 INFO - Running main action method: create_virtualenv 15:42:07 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 15:42:07 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 15:42:07 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 15:42:07 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 15:42:07 INFO - Using real prefix '/usr' 15:42:07 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 15:42:07 INFO - Installing distribute.............................................................................................................................................................................................done. 15:42:09 INFO - Installing pip.................done. 15:42:09 INFO - Return code: 0 15:42:09 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 15:42: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')]} 15:42:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:42:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:42: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')]} 15:42:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:42:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:42: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', '--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 0x7f3740a43c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25746c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26267c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x266ad70>, '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 0x266bb20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x266bfb0>, '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': 'a194aa7faa1be204aaca7d660000020b-1448405851.977553-1733921095', '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 15:42:09 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 15:42:09 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 15:42:09 INFO - Using env: {'DISPLAY': ':0', 15:42:09 INFO - 'HOME': '/home/cltbld', 15:42:09 INFO - 'LANG': 'en_US.UTF-8', 15:42:09 INFO - 'LANGUAGE': 'en_US:en', 15:42:09 INFO - 'LOGNAME': 'cltbld', 15:42:09 INFO - 'MAIL': '/var/mail/cltbld', 15:42:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:42:09 INFO - 'MOZ_NO_REMOTE': '1', 15:42:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:42:09 INFO - 'NO_EM_RESTART': '1', 15:42:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:42:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 15:42:09 INFO - 'PWD': '/builds/slave/test-pgo', 15:42:09 INFO - 'SHELL': '/bin/bash', 15:42:09 INFO - 'SHLVL': '1', 15:42:09 INFO - 'TERM': 'linux', 15:42:09 INFO - 'TMOUT': '86400', 15:42:09 INFO - 'USER': 'cltbld', 15:42:09 INFO - 'XDG_SESSION_COOKIE': 'a194aa7faa1be204aaca7d660000020b-1448405851.977553-1733921095', 15:42:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:42:09 INFO - '_': '/tools/buildbot/bin/python'} 15:42:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:42:10 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 15:42:10 INFO - Cleaning up... 15:42:10 INFO - Return code: 0 15:42:10 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 15:42:10 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')]} 15:42:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:42:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:42:10 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')]} 15:42:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:42:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:42:10 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 0x7f3740a43c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25746c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26267c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x266ad70>, '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 0x266bb20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x266bfb0>, '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': 'a194aa7faa1be204aaca7d660000020b-1448405851.977553-1733921095', '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 15:42:10 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 15:42:10 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 15:42:10 INFO - Using env: {'DISPLAY': ':0', 15:42:10 INFO - 'HOME': '/home/cltbld', 15:42:10 INFO - 'LANG': 'en_US.UTF-8', 15:42:10 INFO - 'LANGUAGE': 'en_US:en', 15:42:10 INFO - 'LOGNAME': 'cltbld', 15:42:10 INFO - 'MAIL': '/var/mail/cltbld', 15:42:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:42:10 INFO - 'MOZ_NO_REMOTE': '1', 15:42:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:42:10 INFO - 'NO_EM_RESTART': '1', 15:42:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:42:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 15:42:10 INFO - 'PWD': '/builds/slave/test-pgo', 15:42:10 INFO - 'SHELL': '/bin/bash', 15:42:10 INFO - 'SHLVL': '1', 15:42:10 INFO - 'TERM': 'linux', 15:42:10 INFO - 'TMOUT': '86400', 15:42:10 INFO - 'USER': 'cltbld', 15:42:10 INFO - 'XDG_SESSION_COOKIE': 'a194aa7faa1be204aaca7d660000020b-1448405851.977553-1733921095', 15:42:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:42:10 INFO - '_': '/tools/buildbot/bin/python'} 15:42:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:42:10 INFO - Downloading/unpacking psutil>=0.7.1 15:42:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:42:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:42:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:42:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:42:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:42:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:42:12 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 15:42:12 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 15:42:12 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 15:42:12 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:42:12 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:42:12 INFO - Installing collected packages: psutil 15:42:12 INFO - Running setup.py install for psutil 15:42:12 INFO - building 'psutil._psutil_linux' extension 15:42:12 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 15:42:12 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 15:42:12 INFO - building 'psutil._psutil_posix' extension 15:42:12 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 15:42:12 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 15:42:12 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:42:12 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:42:12 INFO - Successfully installed psutil 15:42:12 INFO - Cleaning up... 15:42:12 INFO - Return code: 0 15:42:12 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 15:42:12 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')]} 15:42:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:42:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:42:12 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')]} 15:42:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:42:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:42:12 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 0x7f3740a43c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25746c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26267c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x266ad70>, '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 0x266bb20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x266bfb0>, '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': 'a194aa7faa1be204aaca7d660000020b-1448405851.977553-1733921095', '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 15:42:12 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 15:42:12 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 15:42:12 INFO - Using env: {'DISPLAY': ':0', 15:42:12 INFO - 'HOME': '/home/cltbld', 15:42:12 INFO - 'LANG': 'en_US.UTF-8', 15:42:12 INFO - 'LANGUAGE': 'en_US:en', 15:42:12 INFO - 'LOGNAME': 'cltbld', 15:42:12 INFO - 'MAIL': '/var/mail/cltbld', 15:42:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:42:12 INFO - 'MOZ_NO_REMOTE': '1', 15:42:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:42:12 INFO - 'NO_EM_RESTART': '1', 15:42:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:42:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 15:42:12 INFO - 'PWD': '/builds/slave/test-pgo', 15:42:12 INFO - 'SHELL': '/bin/bash', 15:42:12 INFO - 'SHLVL': '1', 15:42:12 INFO - 'TERM': 'linux', 15:42:12 INFO - 'TMOUT': '86400', 15:42:12 INFO - 'USER': 'cltbld', 15:42:12 INFO - 'XDG_SESSION_COOKIE': 'a194aa7faa1be204aaca7d660000020b-1448405851.977553-1733921095', 15:42:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:42:12 INFO - '_': '/tools/buildbot/bin/python'} 15:42:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:42:12 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 15:42:12 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 15:42:12 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 15:42:12 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 15:42:12 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 15:42:12 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 15:42:12 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 15:42:14 INFO - Downloading mozsystemmonitor-0.0.tar.gz 15:42:14 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 15:42:14 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 15:42:14 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 15:42:14 INFO - Installing collected packages: mozsystemmonitor 15:42:14 INFO - Running setup.py install for mozsystemmonitor 15:42:14 INFO - Successfully installed mozsystemmonitor 15:42:14 INFO - Cleaning up... 15:42:14 INFO - Return code: 0 15:42:14 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 15:42:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:42:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:42:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:42:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:42:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:42:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:42:14 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--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 0x7f3740a43c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25746c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26267c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x266ad70>, '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 0x266bb20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x266bfb0>, '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': 'a194aa7faa1be204aaca7d660000020b-1448405851.977553-1733921095', '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 15:42:14 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 15:42:14 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 15:42:14 INFO - Using env: {'DISPLAY': ':0', 15:42:14 INFO - 'HOME': '/home/cltbld', 15:42:14 INFO - 'LANG': 'en_US.UTF-8', 15:42:14 INFO - 'LANGUAGE': 'en_US:en', 15:42:14 INFO - 'LOGNAME': 'cltbld', 15:42:14 INFO - 'MAIL': '/var/mail/cltbld', 15:42:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:42:14 INFO - 'MOZ_NO_REMOTE': '1', 15:42:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:42:14 INFO - 'NO_EM_RESTART': '1', 15:42:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:42:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 15:42:14 INFO - 'PWD': '/builds/slave/test-pgo', 15:42:14 INFO - 'SHELL': '/bin/bash', 15:42:14 INFO - 'SHLVL': '1', 15:42:14 INFO - 'TERM': 'linux', 15:42:14 INFO - 'TMOUT': '86400', 15:42:14 INFO - 'USER': 'cltbld', 15:42:14 INFO - 'XDG_SESSION_COOKIE': 'a194aa7faa1be204aaca7d660000020b-1448405851.977553-1733921095', 15:42:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:42:14 INFO - '_': '/tools/buildbot/bin/python'} 15:42:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:42:14 INFO - Downloading/unpacking blobuploader==1.2.4 15:42:14 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 15:42:14 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 15:42:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:42:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:42:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:42:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:42:16 INFO - Downloading blobuploader-1.2.4.tar.gz 15:42:16 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 15:42:16 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 15:42:16 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 15:42:16 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 15:42:16 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 15:42:16 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 15:42:16 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 15:42:16 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 15:42:16 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 15:42:16 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 15:42:16 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 15:42:17 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 15:42:17 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 15:42:17 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 15:42:17 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 15:42:17 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 15:42:17 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 15:42:17 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 15:42:17 INFO - Downloading docopt-0.6.1.tar.gz 15:42:17 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 15:42:17 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 15:42:17 INFO - Installing collected packages: blobuploader, requests, docopt 15:42:17 INFO - Running setup.py install for blobuploader 15:42:17 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 15:42:17 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 15:42:17 INFO - Running setup.py install for requests 15:42:17 INFO - Running setup.py install for docopt 15:42:17 INFO - Successfully installed blobuploader requests docopt 15:42:17 INFO - Cleaning up... 15:42:18 INFO - Return code: 0 15:42:18 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 15:42:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:42:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:42:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:42:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:42:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:42:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:42:18 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 0x7f3740a43c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25746c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26267c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x266ad70>, '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 0x266bb20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x266bfb0>, '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': 'a194aa7faa1be204aaca7d660000020b-1448405851.977553-1733921095', '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 15:42:18 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 15:42:18 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 15:42:18 INFO - Using env: {'DISPLAY': ':0', 15:42:18 INFO - 'HOME': '/home/cltbld', 15:42:18 INFO - 'LANG': 'en_US.UTF-8', 15:42:18 INFO - 'LANGUAGE': 'en_US:en', 15:42:18 INFO - 'LOGNAME': 'cltbld', 15:42:18 INFO - 'MAIL': '/var/mail/cltbld', 15:42:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:42:18 INFO - 'MOZ_NO_REMOTE': '1', 15:42:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:42:18 INFO - 'NO_EM_RESTART': '1', 15:42:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:42:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 15:42:18 INFO - 'PWD': '/builds/slave/test-pgo', 15:42:18 INFO - 'SHELL': '/bin/bash', 15:42:18 INFO - 'SHLVL': '1', 15:42:18 INFO - 'TERM': 'linux', 15:42:18 INFO - 'TMOUT': '86400', 15:42:18 INFO - 'USER': 'cltbld', 15:42:18 INFO - 'XDG_SESSION_COOKIE': 'a194aa7faa1be204aaca7d660000020b-1448405851.977553-1733921095', 15:42:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:42:18 INFO - '_': '/tools/buildbot/bin/python'} 15:42:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:42:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 15:42:18 INFO - Running setup.py (path:/tmp/pip-eeXaOa-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 15:42:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 15:42:18 INFO - Running setup.py (path:/tmp/pip-nT_N6T-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 15:42:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 15:42:18 INFO - Running setup.py (path:/tmp/pip-ug8tHb-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 15:42:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 15:42:18 INFO - Running setup.py (path:/tmp/pip-FSBDQp-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 15:42:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 15:42:18 INFO - Running setup.py (path:/tmp/pip-m9DcE2-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 15:42:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 15:42:18 INFO - Running setup.py (path:/tmp/pip-TyYoyP-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 15:42:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 15:42:18 INFO - Running setup.py (path:/tmp/pip-wwg9kq-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 15:42:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 15:42:18 INFO - Running setup.py (path:/tmp/pip-KkQtu0-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 15:42:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 15:42:18 INFO - Running setup.py (path:/tmp/pip-DurbXr-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 15:42:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 15:42:18 INFO - Running setup.py (path:/tmp/pip-IGvXsG-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 15:42:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 15:42:18 INFO - Running setup.py (path:/tmp/pip-jdjNXc-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 15:42:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 15:42:19 INFO - Running setup.py (path:/tmp/pip-06Bdoc-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 15:42:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 15:42:19 INFO - Running setup.py (path:/tmp/pip-O46rrd-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 15:42:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 15:42:19 INFO - Running setup.py (path:/tmp/pip-Tryd1O-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 15:42:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 15:42:19 INFO - Running setup.py (path:/tmp/pip-zgH0_F-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 15:42:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 15:42:19 INFO - Running setup.py (path:/tmp/pip-5KYHCw-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 15:42:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 15:42:19 INFO - Running setup.py (path:/tmp/pip-PdcXbm-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 15:42:19 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 15:42:19 INFO - Running setup.py install for manifestparser 15:42:19 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 15:42:19 INFO - Running setup.py install for mozcrash 15:42:19 INFO - Running setup.py install for mozdebug 15:42:19 INFO - Running setup.py install for mozdevice 15:42:19 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 15:42:19 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 15:42:19 INFO - Running setup.py install for mozfile 15:42:19 INFO - Running setup.py install for mozhttpd 15:42:20 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 15:42:20 INFO - Running setup.py install for mozinfo 15:42:20 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 15:42:20 INFO - Running setup.py install for mozInstall 15:42:20 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 15:42:20 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 15:42:20 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 15:42:20 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 15:42:20 INFO - Running setup.py install for mozleak 15:42:20 INFO - Running setup.py install for mozlog 15:42:20 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 15:42:20 INFO - Running setup.py install for moznetwork 15:42:20 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 15:42:20 INFO - Running setup.py install for mozprocess 15:42:20 INFO - Running setup.py install for mozprofile 15:42:20 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 15:42:20 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 15:42:20 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 15:42:20 INFO - Running setup.py install for mozrunner 15:42:20 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 15:42:20 INFO - Running setup.py install for mozscreenshot 15:42:21 INFO - Running setup.py install for moztest 15:42:21 INFO - Running setup.py install for mozversion 15:42:21 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 15:42:21 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 15:42:21 INFO - Cleaning up... 15:42:21 INFO - Return code: 0 15:42:21 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 15:42:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:42:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:42:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:42:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:42:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:42:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:42:21 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 0x7f3740a43c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25746c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26267c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x266ad70>, '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 0x266bb20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x266bfb0>, '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': 'a194aa7faa1be204aaca7d660000020b-1448405851.977553-1733921095', '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 15:42:21 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 15:42:21 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 15:42:21 INFO - Using env: {'DISPLAY': ':0', 15:42:21 INFO - 'HOME': '/home/cltbld', 15:42:21 INFO - 'LANG': 'en_US.UTF-8', 15:42:21 INFO - 'LANGUAGE': 'en_US:en', 15:42:21 INFO - 'LOGNAME': 'cltbld', 15:42:21 INFO - 'MAIL': '/var/mail/cltbld', 15:42:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:42:21 INFO - 'MOZ_NO_REMOTE': '1', 15:42:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:42:21 INFO - 'NO_EM_RESTART': '1', 15:42:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:42:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 15:42:21 INFO - 'PWD': '/builds/slave/test-pgo', 15:42:21 INFO - 'SHELL': '/bin/bash', 15:42:21 INFO - 'SHLVL': '1', 15:42:21 INFO - 'TERM': 'linux', 15:42:21 INFO - 'TMOUT': '86400', 15:42:21 INFO - 'USER': 'cltbld', 15:42:21 INFO - 'XDG_SESSION_COOKIE': 'a194aa7faa1be204aaca7d660000020b-1448405851.977553-1733921095', 15:42:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:42:21 INFO - '_': '/tools/buildbot/bin/python'} 15:42:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:42:21 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 15:42:21 INFO - Running setup.py (path:/tmp/pip-acD9gA-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 15:42:21 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)) 15:42:21 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 15:42:21 INFO - Running setup.py (path:/tmp/pip-Ej6lgy-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 15:42:21 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)) 15:42:21 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 15:42:21 INFO - Running setup.py (path:/tmp/pip-JSBOld-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 15:42:21 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)) 15:42:21 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 15:42:21 INFO - Running setup.py (path:/tmp/pip-2zj3Tb-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 15:42:21 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)) 15:42:21 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 15:42:21 INFO - Running setup.py (path:/tmp/pip-L6WfUJ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 15:42:21 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)) 15:42:21 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 15:42:21 INFO - Running setup.py (path:/tmp/pip-pSWeSP-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 15:42:21 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)) 15:42:21 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 15:42:21 INFO - Running setup.py (path:/tmp/pip-LtLtWI-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 15:42:21 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)) 15:42:21 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 15:42:21 INFO - Running setup.py (path:/tmp/pip-13YKfx-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 15:42:22 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)) 15:42:22 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 15:42:22 INFO - Running setup.py (path:/tmp/pip-xIG6FK-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 15:42:22 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)) 15:42:22 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 15:42:22 INFO - Running setup.py (path:/tmp/pip-0hJQwK-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 15:42:22 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)) 15:42:22 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 15:42:22 INFO - Running setup.py (path:/tmp/pip-QNnQOy-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 15:42:22 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)) 15:42:22 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 15:42:22 INFO - Running setup.py (path:/tmp/pip-fBq_H5-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 15:42:22 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)) 15:42:22 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 15:42:22 INFO - Running setup.py (path:/tmp/pip-V2MHns-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 15:42:22 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)) 15:42:22 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 15:42:22 INFO - Running setup.py (path:/tmp/pip-h7rHLJ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 15:42:22 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)) 15:42:22 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 15:42:22 INFO - Running setup.py (path:/tmp/pip-0LiMQ4-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 15:42:22 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)) 15:42:22 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 15:42:22 INFO - Running setup.py (path:/tmp/pip-8NE0n5-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 15:42:22 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)) 15:42:22 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 15:42:22 INFO - Running setup.py (path:/tmp/pip-udIpxc-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 15:42:22 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)) 15:42:22 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)) 15:42:22 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)) 15:42:22 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)) 15:42:22 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)) 15:42:22 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)) 15:42:22 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 15:42:22 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 15:42:22 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 15:42:22 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 15:42:22 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 15:42:22 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 15:42:22 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 15:42:24 INFO - Downloading blessings-1.5.1.tar.gz 15:42:24 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 15:42:24 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 15:42:24 INFO - Installing collected packages: blessings 15:42:24 INFO - Running setup.py install for blessings 15:42:24 INFO - Successfully installed blessings 15:42:24 INFO - Cleaning up... 15:42:24 INFO - Return code: 0 15:42:24 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 15:42:24 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 15:42:24 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 15:42:24 INFO - Reading from file tmpfile_stdout 15:42:24 INFO - Current package versions: 15:42:24 INFO - argparse == 1.2.1 15:42:24 INFO - blessings == 1.5.1 15:42:24 INFO - blobuploader == 1.2.4 15:42:24 INFO - docopt == 0.6.1 15:42:24 INFO - manifestparser == 1.1 15:42:24 INFO - mozInstall == 1.12 15:42:24 INFO - mozcrash == 0.16 15:42:24 INFO - mozdebug == 0.1 15:42:24 INFO - mozdevice == 0.47 15:42:24 INFO - mozfile == 1.2 15:42:24 INFO - mozhttpd == 0.7 15:42:24 INFO - mozinfo == 0.9 15:42:24 INFO - mozleak == 0.1 15:42:24 INFO - mozlog == 3.1 15:42:24 INFO - moznetwork == 0.27 15:42:24 INFO - mozprocess == 0.22 15:42:24 INFO - mozprofile == 0.27 15:42:24 INFO - mozrunner == 6.11 15:42:24 INFO - mozscreenshot == 0.1 15:42:24 INFO - mozsystemmonitor == 0.0 15:42:24 INFO - moztest == 0.7 15:42:24 INFO - mozversion == 1.4 15:42:24 INFO - psutil == 3.1.1 15:42:24 INFO - requests == 1.2.3 15:42:24 INFO - wsgiref == 0.1.2 15:42:24 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 15:42: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')]} 15:42:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:42:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:42: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')]} 15:42:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:42:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:42:24 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 0x7f3740a43c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25746c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26267c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x266ad70>, '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 0x266bb20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x266bfb0>, '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': 'a194aa7faa1be204aaca7d660000020b-1448405851.977553-1733921095', '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 15:42:24 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 15:42:24 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 15:42:24 INFO - Using env: {'DISPLAY': ':0', 15:42:24 INFO - 'HOME': '/home/cltbld', 15:42:24 INFO - 'LANG': 'en_US.UTF-8', 15:42:24 INFO - 'LANGUAGE': 'en_US:en', 15:42:24 INFO - 'LOGNAME': 'cltbld', 15:42:24 INFO - 'MAIL': '/var/mail/cltbld', 15:42:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:42:24 INFO - 'MOZ_NO_REMOTE': '1', 15:42:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:42:24 INFO - 'NO_EM_RESTART': '1', 15:42:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:42:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 15:42:24 INFO - 'PWD': '/builds/slave/test-pgo', 15:42:24 INFO - 'SHELL': '/bin/bash', 15:42:24 INFO - 'SHLVL': '1', 15:42:24 INFO - 'TERM': 'linux', 15:42:24 INFO - 'TMOUT': '86400', 15:42:24 INFO - 'USER': 'cltbld', 15:42:24 INFO - 'XDG_SESSION_COOKIE': 'a194aa7faa1be204aaca7d660000020b-1448405851.977553-1733921095', 15:42:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:42:24 INFO - '_': '/tools/buildbot/bin/python'} 15:42:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:42:25 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)) 15:42:25 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)) 15:42:25 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)) 15:42:25 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)) 15:42:25 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)) 15:42:25 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)) 15:42:25 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)) 15:42:25 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)) 15:42:25 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)) 15:42:25 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)) 15:42:25 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)) 15:42:25 INFO - Cleaning up... 15:42:25 INFO - Return code: 0 15:42:25 INFO - Running post-action listener: _resource_record_post_action 15:42:25 INFO - Running post-action listener: _start_resource_monitoring 15:42:25 INFO - Starting resource monitoring. 15:42:25 INFO - ##### 15:42:25 INFO - ##### Running install step. 15:42:25 INFO - ##### 15:42:25 INFO - Running pre-action listener: _resource_record_pre_action 15:42:25 INFO - Running main action method: install 15:42:25 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 15:42:25 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 15:42:25 INFO - Reading from file tmpfile_stdout 15:42:25 INFO - Detecting whether we're running mozinstall >=1.0... 15:42:25 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 15:42:25 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 15:42:25 INFO - Reading from file tmpfile_stdout 15:42:25 INFO - Output received: 15:42:25 INFO - Usage: mozinstall [options] installer 15:42:25 INFO - Options: 15:42:25 INFO - -h, --help show this help message and exit 15:42:25 INFO - -d DEST, --destination=DEST 15:42:25 INFO - Directory to install application into. [default: 15:42:25 INFO - "/builds/slave/test-pgo"] 15:42:25 INFO - --app=APP Application being installed. [default: firefox] 15:42:25 INFO - mkdir: /builds/slave/test-pgo/build/application 15:42:25 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'] 15:42:25 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 15:42:39 INFO - Reading from file tmpfile_stdout 15:42:39 INFO - Output received: 15:42:39 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 15:42:39 INFO - Running post-action listener: _resource_record_post_action 15:42:39 INFO - ##### 15:42:39 INFO - ##### Running run-tests step. 15:42:39 INFO - ##### 15:42:39 INFO - Running pre-action listener: _resource_record_pre_action 15:42:39 INFO - Running main action method: run_tests 15:42:39 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 15:42:39 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 15:42:39 INFO - Python 2.7.3 15:42:39 INFO - Return code: 0 15:42:39 INFO - grabbing minidump binary from tooltool 15:42: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')]} 15:42:39 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 0x266ad70>, '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 0x266bb20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x266bfb0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 15:42:39 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 15:42:39 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 15:42:39 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 15:42:39 INFO - Return code: 0 15:42:39 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 15:42:39 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 15:42:39 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 15:42:39 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 15:42:39 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 15:42:39 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/sDvUxvG9T1m4MMYOh9Qddg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-033', '--webServer', 'localhost'] in /builds/slave/test-pgo/build 15:42:39 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/sDvUxvG9T1m4MMYOh9Qddg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-033 --webServer localhost 15:42:39 INFO - Using env: {'DISPLAY': ':0', 15:42:39 INFO - 'HOME': '/home/cltbld', 15:42:39 INFO - 'LANG': 'en_US.UTF-8', 15:42:39 INFO - 'LANGUAGE': 'en_US:en', 15:42:39 INFO - 'LOGNAME': 'cltbld', 15:42:39 INFO - 'MAIL': '/var/mail/cltbld', 15:42:39 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 15:42:39 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 15:42:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:42:39 INFO - 'MOZ_NO_REMOTE': '1', 15:42:39 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 15:42:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:42:39 INFO - 'NO_EM_RESTART': '1', 15:42:39 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:42:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 15:42:39 INFO - 'PWD': '/builds/slave/test-pgo', 15:42:39 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 15:42:39 INFO - 'SHELL': '/bin/bash', 15:42:39 INFO - 'SHLVL': '1', 15:42:39 INFO - 'TERM': 'linux', 15:42:39 INFO - 'TMOUT': '86400', 15:42:39 INFO - 'USER': 'cltbld', 15:42:39 INFO - 'XDG_SESSION_COOKIE': 'a194aa7faa1be204aaca7d660000020b-1448405851.977553-1733921095', 15:42:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:42:39 INFO - '_': '/tools/buildbot/bin/python'} 15:42:39 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/sDvUxvG9T1m4MMYOh9Qddg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-033', '--webServer', 'localhost'] with output_timeout 3600 15:42:40 INFO - mozversion INFO | application_buildid: 20151124143004 15:42:40 INFO - mozversion INFO | application_changeset: 8a3e98127ebc28fcc01d27bdedb4c959a456c47d 15:42:40 INFO - mozversion INFO | application_display_name: Nightly 15:42:40 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 15:42:40 INFO - mozversion INFO | application_name: Firefox 15:42:40 INFO - mozversion INFO | application_remotingname: firefox 15:42:40 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/fx-team 15:42:40 INFO - mozversion INFO | application_vendor: Mozilla 15:42:40 INFO - mozversion INFO | application_version: 45.0a1 15:42:40 INFO - mozversion INFO | platform_buildid: 20151124143004 15:42:40 INFO - mozversion INFO | platform_changeset: 8a3e98127ebc28fcc01d27bdedb4c959a456c47d 15:42:40 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/fx-team 15:42:40 INFO - mozversion INFO | platform_version: 45.0a1 15:42:40 INFO - 2015-11-24 15:42:40,109 DEBUG : using testdate: 1448408560 15:42:40 INFO - 2015-11-24 15:42:40,109 DEBUG : actual date: 1448408560 15:42:40 INFO - 2015-11-24 15:42:40,157 INFO : starting webserver on 'localhost:35871' 15:42:40 INFO - 2015-11-24 15:42:40,158 INFO : Starting test suite talos-linux64-ix-033 15:42:40 INFO - 2015-11-24 15:42:40,159 INFO : Starting test dromaeo_css 15:42:40 INFO - 2015-11-24 15:42:40,159 DEBUG : operating with platform_type : linux_ 15:42:40 INFO - 2015-11-24 15:42:40,159 INFO : Initialising browser for dromaeo_css test... 15:42:40 INFO - 2015-11-24 15:42:40,176 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpi4FryD/profile http://localhost:35871/getInfo.html 15:42:44 INFO - 2015-11-24 15:42:44,822 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 15:42:44 INFO - 2015-11-24 15:42:44,822 DEBUG : BROWSER_OUTPUT: colorDepth:24 15:42:44 INFO - 2015-11-24 15:42:44,822 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 15:42:44 INFO - 2015-11-24 15:42:44,822 DEBUG : BROWSER_OUTPUT: __metrics 15:42:44 INFO - 2015-11-24 15:42:44,943 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 15:42:46 INFO - 2015-11-24 15:42:46,697 INFO : Browser initialized. 15:42:46 INFO - 2015-11-24 15:42:46,697 INFO : Running cycle 1/1 for dromaeo_css test... 15:42:46 INFO - 2015-11-24 15:42:46,697 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpi4FryD/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 15:42:58 INFO - 2015-11-24 15:42:58,442 DEBUG : BROWSER_OUTPUT: RSS: Main: 140783616 15:42:58 INFO - 2015-11-24 15:42:58,442 DEBUG : BROWSER_OUTPUT: 15:43:50 INFO - 2015-11-24 15:43:50,074 DEBUG : BROWSER_OUTPUT: 1448408630069 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] 15:45:59 INFO - 2015-11-24 15:45:59,049 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:35871/tests/dromaeo/cssquery-dojo.html (next: http://localhost:35871/tests/dromaeo/cssquery-ext.html) 15:46:00 INFO - 2015-11-24 15:46:00,085 DEBUG : BROWSER_OUTPUT: RSS: Main: 241192960 15:46:00 INFO - 2015-11-24 15:46:00,085 DEBUG : BROWSER_OUTPUT: 15:49:02 INFO - 2015-11-24 15:49:02,467 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:35871/tests/dromaeo/cssquery-ext.html (next: http://localhost:35871/tests/dromaeo/cssquery-jquery.html) 15:49:03 INFO - 2015-11-24 15:49:03,036 DEBUG : BROWSER_OUTPUT: RSS: Main: 221609984 15:49:03 INFO - 2015-11-24 15:49:03,036 DEBUG : BROWSER_OUTPUT: 15:52:05 INFO - 2015-11-24 15:52:05,051 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:35871/tests/dromaeo/cssquery-jquery.html (next: http://localhost:35871/tests/dromaeo/cssquery-mootools.html) 15:52:05 INFO - 2015-11-24 15:52:05,620 DEBUG : BROWSER_OUTPUT: RSS: Main: 220717056 15:52:05 INFO - 2015-11-24 15:52:05,620 DEBUG : BROWSER_OUTPUT: 15:55:07 INFO - 2015-11-24 15:55:07,392 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:35871/tests/dromaeo/cssquery-mootools.html (next: http://localhost:35871/tests/dromaeo/cssquery-prototype.html) 15:55:07 INFO - 2015-11-24 15:55:07,985 DEBUG : BROWSER_OUTPUT: RSS: Main: 197124096 15:55:07 INFO - 2015-11-24 15:55:07,985 DEBUG : BROWSER_OUTPUT: 15:58:10 INFO - 2015-11-24 15:58:10,489 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:35871/tests/dromaeo/cssquery-prototype.html (next: http://localhost:35871/tests/dromaeo/cssquery-yui.html) 15:58:11 INFO - 2015-11-24 15:58:11,064 DEBUG : BROWSER_OUTPUT: RSS: Main: 204623872 15:58:11 INFO - 2015-11-24 15:58:11,064 DEBUG : BROWSER_OUTPUT: 16:01:13 INFO - 2015-11-24 16:01:13,713 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:35871/tests/dromaeo/cssquery-yui.html (next: http://localhost:35871/tests/dromaeo/cssquery-dojo.html) 16:01:13 INFO - 2015-11-24 16:01:13,963 DEBUG : BROWSER_OUTPUT: RSS: Main: 284377088 16:01:13 INFO - 2015-11-24 16:01:13,963 DEBUG : BROWSER_OUTPUT: 16:01:13 INFO - 2015-11-24 16:01:13,963 DEBUG : BROWSER_OUTPUT: __start_tp_report 16:01:13 INFO - 2015-11-24 16:01:13,963 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 16:01:13 INFO - 2015-11-24 16:01:13,963 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 16:01:13 INFO - 2015-11-24 16:01:13,963 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 16:01:13 INFO - 2015-11-24 16:01:13,964 DEBUG : BROWSER_OUTPUT: |0;dojo.html;3191.914748985345;3254.0725893120434;3278.7868788528745;3292.440285151524;3320.9003729888095;5217.921731174036;5348.625596208267;5371.24802527646;5419.26839876616;5422.593305502089;5358.410574836765;5362.892742145154;5375.354957405107;5415.377231618365;5580.609357344987;4910.1898186799135;4937.580305674022;4943.629227807911;4965.404151501825;5063.797448102072;5015.5486006259425;5071.137906555894;5087.974560127194;5104.175465969676;5108.259302401149;4800.543948324921;4872.220444728827;4914.606831453475;4982.277569752366;5007.549320561149;4965.081459929925;4969.378827646544;4972.552470277692;4983.900321993576;5019.749012549394;4932.161532539477;4938.38270216223;4943.678660887067;4949.183384741549;4972.229304457815;5058.54473097423;5201.531862132426;5209.557187639018;5286.15421532553;5336.17289320156;5880.117982302646;5881.000229960917;5890.646561206298;5894.204282421904;5913.674747888907;5700.914486282709;5930.97034514829;5933.970330148365;5935.9406405935815;5937.139114828326;5400.135978243501;5463.2078348639625;5474.343078830526;5482.890342193134;5529.834104976857;5978.372270911578;5994.37059108796;6007.729652165575;6013.188219590387;6058.909116363258;5575.358833734092;5738.397468265855;5740.770369185269;5746.310442746897;5762;5604.3835178130375;5667.659940403589;5670.886582268332;5722.942770572241;5795.1886735857015;5878.2358293421585;5883.61756485827;5902.026165682701;5941.376155503696;5947.821565353046;5739.770409183586;5818.7672493100645;5914.733836977346;5923.111533269957;5928.6146400484695;4485.394471746337;4517.728936263835;4549.977250113794;4569.2689169732685;4584.060267645124;4008.038070862972;4028;4029.435878976946;4062.045419326456;4067.613576710208;5405.21624364465;5596.552275817925;5599.300087489064;5600.747966341524;5604.60767746262;5795.855103622359;5849.532037436995;5871.3541510433815;5877.617954832922;5896.056630939029;5606.243157173811;5607.383187849333;5610.915836262459;5628.971855140698;5630.60585758993;5113.207452844741;5146.073706732824;5152.639315247897;5159.2003239497935;5206.114960456732;5871.530277577784;6058.0610005449225;6060.484858787053;6061.575689701766;6139.171211886427;5731.656100633975;5808.099744539603;5853.0635098384055;5858.531317494675;5862.355140934579;6202.472789812917;6244.375562443719;6267.435930766253;6276.592021518587;6280.905786413116;5602;5812.883742325214;5873.148393482836;5879.647221166743;5934.3175534814045;5715.914261286167;5724.685142317213;5751.511121554715;5835.095560188178;5845.736941837713;5773.942260577341;5815.011448053926;5837.153612726216;5837.270341207349;5842.678652673973;5675.177099320493;5780.710964451677;5792.391798861059;5798.043322851682;5798.391168927371;5374.57003439716;5506.256655351636;5509.834704958857;5712.171735098471;5730.914036289542;5649.265595472562;5683.8863222736145;5685.459881311269;5744.42555744439;5764.365919748908;5547.472990065938;5645.294338207724;5663.8867222656145;5685.77256909719;5704.401037890962 16:01:13 INFO - 2015-11-24 16:01:13,966 DEBUG : BROWSER_OUTPUT: |1;ext.html;559.8768270980386;598.1147901106362;605.4399680295727;622.9968850155749;655.7704803318838;30757.38485230294;31534;39695.60304396959;40672.59327406725;40774;42890.78554607223;43399.13201735971;43482.78258608703;43496.347554786706;43500.3474947876;7561.924380756177;8680.218780309786;8779.429337093068;8853.380263381567;8858.468491890475;7478.925210747904;7535.284148005931;10552.525136368882;10842.186835987293;10845.891541084568;10476.528556214951;10482;10483.423411712352;10485.58057677692;10598.099161571276;7631.809204769869;7838.333741631911;10256.128229100535;10380.740481487948;10396.792064158712;10445.791084178274;10754.193435492369;10763.83854242187;10764.892351076467;10768.623098191603;38617.613823861684;38867.8056609718;38967.220655587014;38978;38982.22035559301;3242.789218700777;3282.1302354875975;3291.835408229579;3585.982070089633;3918.74528155669;29816;30123.397532049454;30360.696393036007;30472.190976127986;30712.53931191034;3677.558692956862;3693.169036966688;3750.49368335274;3750.587435382106;3794.0704527390967;263168;264073;264720;265120;266555;51346;52335;57655.423445765846;57928;58455.70772146112;59305.70347148237;59392.70303648454;59508;59549.40450595525;59832;14297.928510357382;14475.49335773264;14483.131012139094;14487.927560362341;14502.492412765503;11050.778984420267;11113.555457781598;11142;11148.554057837759;11182.16133789969;19304.1313140909;19599.902000489907;19604.411867643994;19616.50958726015;19664.70502942457;7936.166702496154;7943.761687149395;7976.601169941479;8027.357811375076;8053.677852885936;913.8355096082636;965.1072757699101;1026.7843752811993;1052.4474650808386;1054.894510548939;27039.729602703723;27688.723112769017;27741.861290693418;28179.577306340423;28244.15267541977;1045.3498838776425;1089.9564017439213;1096.6709987004026;1135.1769966774023;1165.6677846813618;13257;14033.71932561343;14148.717025659429;14189.78715319271;14278.643033924234;707119;731480;732622;734066;735774;57568.4243157563;58260.70869645625;58278.7086064567;58286.417135828946;58459;1382.4401117547409;1394.7071115065746;1395.490645914234;1395.818543589327;1396.2460271453301;29377.412451751272;30654;30743;30864;31203.219919502193;46161;46653.76673116613;46670.76664616655;46694.76652616851;46700.06599867916;275677;276335;277624;279262;301860;27263.45473090567;31717.20706982344;31734;32124;32424.675753243107;42063.57936420719;43092.569074308856;43110.78444607757;43396.56603433925;43930.56069439393;36669.44995825118;36934.8153259232;37272.44091338578;37399.62600373961;37958.43062354122;30426.239344016576;36450.45324320084;40025.199496009336;40598.1880362397;42003.36994945139;36054.63945360513;36672;36746.816265919566;37192.44211336886;37623.2475350486;32292;37587.81206094062;37608.43587346137;39212.6078739209;39406.408903867035;25440.23679289624;26502.337441564116;28121.718782812728;28183.154505364873;28218.153455396372 16:01:13 INFO - 2015-11-24 16:01:13,968 DEBUG : BROWSER_OUTPUT: |2;jquery.html;355.85409981907407;358.22554316816246;359.99100022499437;363.0343286856959;364.89600463867805;14164;14293.14241145532;16365.672686546262;16696.16519174041;17400.564985875342;13259.138156019852;14268.215248161347;15810.525684229491;16576;16677.332906683747;5289.074411977898;5396.514313711765;5404.91892621611;5407.729613519308;5458.962797068564;3989.2021595680835;4105.630493255607;5352.732363381835;5405.324334458192;5874.765009399619;6023.337432882379;6027.246594175728;6033.09503574463;6065.393460653943;6094.207752992105;5536.335639723239;5645;5657.09486482165;5675.3757086720425;6055;4994.675346102492;5032.245163225509;5072.54347108762;5212.087884620177;5213.817516386946;11569.421528923604;11592.536298548048;11820.70448238801;11832.467538960767;12450.626481205578;1974.5063734066484;1984.9007549622606;2024.2206750401053;2092.0376626751713;2119.1417475922276;9329.906700932972;9532.666356677482;9577.23382129428;9857.852132218022;9872.950635246778;1827.159506626953;1875.4186202277338;1931.4591914264029;1973.8815671059783;1974.9769917667893;58586;61049.694751526404;62249.37750622481;62670.99999999954;63143.36856631467;10250.897491025144;10313.071823535767;10338.793224135476;10342.172626190037;10391.376517408828;13431.12697674648;13437.328133593477;13454.52909148175;13454.798178027337;13460.798088028687;7247.855042899112;7332.670029848669;7371.520851144658;7389.224131466119;7482.289182527651;6986.16166060076;7097;7384.113906331275;7439.85120297591;7456.366208872307;4447.177272204653;4517.503074661785;4530.864074077783;4565.086982603492;4567.36056952027;1645.3500867157645;1680.0675625027982;1680.9411670591471;1695.1100672146974;1767.2754170790172;901.6483571407157;916.1205242966827;967.2793768642266;1040.0275742181084;1069.5721711315537;15572.610684732972;16626;16887.91556042212;17183.484495465156;17276.22256998438;898.4743924803932;992.270681049428;1012.2054187462807;1033.0599154769125;1036.8335622424772;9408.811823763486;9488.478133702713;9530.142287194047;9545.188658964065;9648.744025372673;502594;513926;527245;535155;536605;75375.62312188404;79377;80755.59622201852;80828;81429.18570814216;1143.0512674480162;1154.722866512031;1157.6469176900957;1162.7674465106843;1177.8056620657496;14589.489367872498;14751.852481475047;14754;14966.251687415368;15107.32017059257;34887.476687849194;34919.65080349164;34928.30143397067;35157.47263790994;35683.10792230215;45791;48284.27573586329;48318;48362.274565882246;49010.26484602663;9599.088086631758;9725.756856078655;9727.756806079904;9760.46317452547;9821.558029888529;16533.58666033359;16677.666446670755;17115.315387384366;17445.82554174493;17466.91266543659;10703.785924281627;10798.946005269923;12092.516299347928;13508.86491135076;13590.32048397596;13894.930525347309;14465.783013254599;14522.564323070324;14880.107193568421;14980;11797.823032654345;11802.173847830913;12078.275303481467;14126.293685315488;14587.197704126374;9359.251259899056;9668.371555848847;9757.463339516395;9759.9024009759;9791.167750741266;9831.262655300738;10898.85800217374;14471;14626;15200.46798362052 16:01:13 INFO - 2015-11-24 16:01:13,969 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1326.2904346174798;1696.4486541873891;1718.5531761741952;1746.0833062642112;1753.3600235913896;6744.629045402501;6914.619695916723;7030.507864449491;7037.261087585794;7039.577625342483;7222.061132052826;7280.453965952562;7293.307135822089;7314.926850731491;7329.780106596811;2178.9564208715856;2197.571473562656;2199.2412617646964;2199.8350123740784;2200.1639377036704;2190.058274941782;2197.121151539389;2268.0700912625744;2269.387265438331;2270.3529494094105;2157.072458842697;2183.9126434942664;2186.7703891091364;2195.82433405328;2198.329509499602;2194.9890250548806;2205.7683943185893;2219.0569008171624;2219.9001044953015;2220.911163553464;2203.6474164133824;2211.2150186683657;2213.3249358945513;2213.435573928654;2215.4461384653837;6336.176297081396;6512.641804700739;7208.171060328077;7240.746573869942;7242.78271651846;4406.5593440655675;4482;4484.596386325246;4485.506594274627;4498.460184777848;2880.0783749200264;2894.5658151277266;2978.3894301668106;2985.5223164293607;3001.7748668849704;1006.139750513308;1014.122783792022;1015.2334987084778;1040.8282633365486;1041.2555023158477;9750.804983900282;9849.359791613522;9870.45712485813;9875.506224688737;9891.258155638285;4023.5976402360116;4117.114820313647;4148.128892932457;4157.771322577227;4179.707420480538;8495.36284778644;8519.659213631508;8528.445651032664;8608.139186081467;8609.225169734755;4553.385292985471;4555.134524440346;4600.95399046012;4606.378138951266;4607.308903664477;4165.479315085614;4180.540140584533;4195.790210489525;4201.411802347674;4202.432671589297;3391.7117045050954;3429.416999110157;3434.0384692286198;3436.037909385376;3436.329915666421;1149.747055647756;1175.2243519277235;1178.452019810792;1181.3207405741732;1182.7870983223102;1011.9797604047877;1052.032130439997;1071.64100026492;1178;1326.7346530693899;6734.8989765153565;6840.144981877265;6885.414739747178;6885.449164066863;6890.44876409886;478.810869706464;479.8752324395682;482.97826597803186;486.85151028936514;489.6499003212649;4943.307936888838;5450.972745136328;5514.172874068921;5515.806946756925;5518.696471694015;7598.430117741192;8320.209580089882;8333.708320208763;8365.498070115813;8442.535660538606;8245.216704413071;8309.37679674027;8334.249917507454;8340.29107525855;8341.374396920255;6359.8092057238355;6573.375529324707;6631.33686631333;6638.900416493757;6645.501587380966;6670.266270710315;6727.663616819042;6774.254831968578;6830.487713421414;6832.795016149524;7709.267619576131;7709.575973321297;7951.3638908886;7959.5622240775;7971.12317645047;7936.325412340016;7979.0425148982495;8121;8127.593620319079;8134.837303253784;6457.386548278094;6500.382463665944;6510.18622672166;6521.608703477807;6524.119243902012;7127.536710113826;7174.067371241706;7175.892361614684;7190.460715446257;7208.8918666219;6499.992501162327;6611.900821487586;6632.2372927114;6719.059331693469;6752.358525940028;6687.465002799667;6696.1629796275465;6718.596884186964;6819.318068193141;6836.726530938707;6482.2869484357625;6500.447461965597;6541.738330466728;6564;6575.967120164369;5922.466977972003;5946.13781001761;5956.106584012259;5960.284765828128;5961.135635332939;6036.9094463582205;6073.544484163794;6095.725692343766;6099.84750381244;6104.389561044038 16:01:13 INFO - 2015-11-24 16:01:13,970 DEBUG : BROWSER_OUTPUT: |4;prototype.html;309.6578280999497;314.49366519902935;323.5712680698075;327.52181814550755;331.241457063325;5864.091065884794;5907.438793314634;5987.191729116568;6001.879962400761;6007.489363404105;5769.740361683724;5861.267341582302;5869.794557190499;5897.439743224398;5922.289325280973;4386.40783494229;4447.9555204448025;4572.0627271409285;4582.198115329804;4586.633069354443;4448.755318457484;4539.931901021488;4545.159145558066;4551.4083169188125;4554.294084416921;4466.754328511931;4473.686841921067;4479.574440428154;4481.2381895077915;4487.708298960557;4478.350639157304;4484.372187893698;4486.4840543337605;4493.393391892086;4494.528074552158;3820.3887378019663;3894;3898.4737060496755;3901.7073719471155;3908.042529580271;5653.547716182696;5656.688882111483;5668.659880407189;5683.3464151622675;5686.943130568683;5238.345206849144;5238.92141617876;5248.21276808478;5248.580113590903;5249.422563518048;6005.609635373687;6110.3889611038985;6182.938170618326;6281.748730050793;6289.339619339949;4391.209582275189;4401.427814384142;4429.977850110761;4430.844920427802;4433.069055498349;6501.609903405763;6507.284198738135;6516;6519.0221466779885;6521.152250207443;4429.335599660077;4511.593956543861;4512.323151527297;4512.75179865104;4529.932051019237;4555.749433781108;4564;4569.1547063793305;4570.954290457119;4584.862454126382;5255;5255.5532779713385;5266.473352664703;5268.130758424893;5270.077736396115;6303.779367722108;6311.90532142009;6316.747330106836;6318.778842740482;6321.589096708699;1593.1635891157234;1599.808023037243;1626.8047834259964;1628.2184551415387;1631.8041834979879;1084.6854412220368;1086.663134428314;1091.748897753521;1094.6934858239706;1095.1074873977682;6168.444839964424;6169.784057558054;6177.722002509898;6180.505559555225;6181.505479561624;6490.156279683705;6491.350864913471;6492;6499.480041596661;6529.673516324165;6086.117512960596;6181.84545386369;6193.1329613854095;6194.752209911643;6201.534884883562;3505.5618047744033;3528.647135286451;3537.893863184109;3538.7522873398616;3544.025393016889;6788.694508747019;6796.422304104207;6838.829029274209;6842;6862.039314495974;6655.800325990228;6699.062131301622;6700.262971073178;6708.664566771642;6720.865582688319;6703.865922681616;6908.378245957888;6918.861622767517;6927.792166235021;6931.064306318583;6340.9048864268;6385.808425747235;6460.806175814733;6538.1827271591055;6569.343065693583;6365.077063825626;6402.935970640234;6419.325970773001;6425.389587989133;6451.451626611791;6767.35710107539;6829.453643708392;6841.3842754152365;6871.656417179221;6874.9656251718425;4402.977985110054;4433.556644335541;4438.889027774331;4440.533743956838;4445.37764712947;6548.214214294125;6559.508036897157;6559.8032059038305;6565.048068030204;6565.409113179837;6381.8085457436355;6388.041793730978;6389.584676995981;6390.233172019387;6393.87212255743;6260.843478913063;6354.777582784581;6355.682215889279;6361.491080713439;6365.14070600463;6228.968855155877;6229.283632382334;6231.813045608639;6237.7193026314835;6247.406496382836;6362.04569314588;6367.586106903036;6374.426301632875;6377.521685873671;6398.360163983564;6009.45914867664;6048.60684055535;6084.817455476343;6119.84700382494;6155.35368786271 16:01:13 INFO - 2015-11-24 16:01:13,972 DEBUG : BROWSER_OUTPUT: |5;yui.html;746.73117677636;763.9503432276903;771.0901136658744;803.4351050740928;824.4352618456358;13773.93113034436;13817;13960.790588141186;14020.088694234868;14021.088629239104;13015.674608134777;13196.736065278712;13226.140300880435;13230.338483075855;13234.53679121231;674.8009337245525;677.7085853083172;677.7593954146256;805.7542449552884;820.8235229425673;678.372505432473;806.4516129032256;815.4903185509057;817.9713710020151;821.4742564758529;856.4732689396039;864.2178828160525;864.7059999600135;864.8140649760301;865.4417900454204;854.1927878155146;854.2695994924344;855.5123579559654;855.6662901468401;862.1249431826701;519.4078750224746;523.9659422137549;609.6464050850497;614.827848202504;617.9938200618026;13051.955843532494;13152.40814163365;13161.670958226025;13196.86803131966;13198.076134670577;11676.007539359165;11787.351695656735;11979.221350612183;12163.148579599432;12392.442340094627;9937.453440060794;10178.236632252536;10319.226058045602;10389.168866490738;10494.212934029978;3545.0960005198767;3556.875509357186;3563.1092226943265;3620.149264922741;3665.083729067733;46201.768991155164;46225;46364.76817615924;46502.76748616269;46761.06477870423;10052.69841904744;10206.795864082826;10247.436390998417;10259.897401025893;10297.845532317022;18084.9095754523;18254.178561964476;18290.17694203764;18307.35924242672;18318.267269309345;7467;7472.738454154079;7588.241175882367;7680;7773.727919522903;4208.137331846964;4240.257954857888;4261.765602891809;4278.026995036673;4308.482982042175;3042.741366983831;3047.7714171437233;3052.0538633023834;3052.3590046090126;3057.4649436348996;528.6986417741928;532.1299675031352;543.5868739757813;546.9343678758574;551.3962211378534;601.8465291350765;627.1345543150424;646.1890327638877;662.7150325360142;663.5620490476263;8221;8430.11483794205;8763.605637746317;8783.121687831166;9074.954625226832;443.7825465521871;490.69331667707684;496.39687779348264;511.330157493677;644.4618743349356;3737.3192747024373;3802.7147963902817;3813.199228162117;3871.341871881787;4052.1490486997473;52641;52726.73636631869;52829.735851320496;53247;54223;48623.5137648619;49105.263421048716;49235;50095;50446.243306350436;45707.31439028417;46049;46305.07389852184;46360.53639463562;46560.767196163804;8528.403011789364;8533.701320453754;8553.230209281195;8564.143585641636;8762.693305734269;34843.30313393768;35856.820715896254;36011.09972250715;36111;36126.27747444984;43594.78202608967;44873.775631121636;45084;45499.54500454953;45726.77136614296;9678.531629629237;9866.358686685342;10014.39913605186;10308.381497109898;10523.526441310312;11287.209895307578;11462.484188211383;11501.597444089417;11653.30080195191;11669.299842009506;10509.894901050891;10761.730956726144;10769.62306319275;10835.512401941774;10866.249356206023;10732.678019659423;10960.56157753681;10967.945160274148;11360.54557817711;11382.54469821198;10725.356478611307;10854.34873907568;11013.779724405627;11466.541338346373;11502.53989840397;9108.954455227682;9118.95440522793;9304.348695591243;9476.336656433983;9481.905180948102;8606.827863442571;9142.26861851037;9328.580213890527;9330.673426430043;9352.579133938852 16:01:13 INFO - 2015-11-24 16:01:13,972 DEBUG : BROWSER_OUTPUT: __end_tp_report 16:01:13 INFO - 2015-11-24 16:01:13,972 DEBUG : BROWSER_OUTPUT: __start_cc_report 16:01:13 INFO - 2015-11-24 16:01:13,972 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,822 16:01:13 INFO - 2015-11-24 16:01:13,972 DEBUG : BROWSER_OUTPUT: __end_cc_report 16:01:13 INFO - 2015-11-24 16:01:13,972 DEBUG : BROWSER_OUTPUT: __startTimestamp1448409673963__endTimestamp 16:01:13 INFO - 2015-11-24 16:01:13,972 DEBUG : BROWSER_OUTPUT: 16:01:13 INFO - 2015-11-24 16:01:13,972 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 16:01:13 INFO - 2015-11-24 16:01:13,972 DEBUG : BROWSER_OUTPUT: Number of tests: 6 16:01:13 INFO - 2015-11-24 16:01:13,972 DEBUG : BROWSER_OUTPUT: 16:01:13 INFO - 2015-11-24 16:01:13,973 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:5441.86 Median:5645.29 stddev:608.29 (10.8%) stddev-sans-first:583.98 16:01:13 INFO - 2015-11-24 16:01:13,973 DEBUG : BROWSER_OUTPUT: Values: 3191.9 3254.1 3278.8 3292.4 3320.9 5217.9 5348.6 5371.2 5419.3 5422.6 5358.4 5362.9 5375.4 5415.4 5580.6 4910.2 4937.6 4943.6 4965.4 5063.8 5015.5 5071.1 5088.0 5104.2 5108.3 4800.5 4872.2 4914.6 4982.3 5007.5 4965.1 4969.4 4972.6 4983.9 5019.7 4932.2 4938.4 4943.7 4949.2 4972.2 5058.5 5201.5 5209.6 5286.2 5336.2 5880.1 5881.0 5890.6 5894.2 5913.7 5700.9 5931.0 5934.0 5935.9 5937.1 5400.1 5463.2 5474.3 5482.9 5529.8 5978.4 5994.4 6007.7 6013.2 6058.9 5575.4 5738.4 5740.8 5746.3 5762.0 5604.4 5667.7 5670.9 5722.9 5795.2 5878.2 5883.6 5902.0 5941.4 5947.8 5739.8 5818.8 5914.7 5923.1 5928.6 4485.4 4517.7 4550.0 4569.3 4584.1 4008.0 4028.0 4029.4 4062.0 4067.6 5405.2 5596.6 5599.3 5600.7 5604.6 5795.9 5849.5 5871.4 5877.6 5896.1 5606.2 5607.4 5610.9 5629.0 5630.6 5113.2 5146.1 5152.6 5159.2 5206.1 5871.5 6058.1 6060.5 6061.6 6139.2 5731.7 5808.1 5853.1 5858.5 5862.4 6202.5 6244.4 6267.4 6276.6 6280.9 5602.0 5812.9 5873.1 5879.6 5934.3 5715.9 5724.7 5751.5 5835.1 5845.7 5773.9 5815.0 5837.2 5837.3 5842.7 5675.2 5780.7 5792.4 5798.0 5798.4 5374.6 5506.3 5509.8 5712.2 5730.9 5649.3 5683.9 5685.5 5744.4 5764.4 5547.5 5645.3 5663.9 5685.8 5704.4 16:01:13 INFO - 2015-11-24 16:01:13,973 DEBUG : BROWSER_OUTPUT: 16:01:13 INFO - 2015-11-24 16:01:13,973 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:57779.80 Median:3438.91 stddev:128401.43 (3733.8%) stddev-sans-first:128689.76 16:01:13 INFO - 2015-11-24 16:01:13,973 DEBUG : BROWSER_OUTPUT: Values: 559.9 598.1 605.4 623.0 655.8 30757.4 31534.0 39695.6 40672.6 40774.0 42890.8 43399.1 43482.8 43496.3 43500.3 7561.9 8680.2 8779.4 8853.4 8858.5 7478.9 7535.3 10552.5 10842.2 10845.9 10476.5 10482.0 10483.4 10485.6 10598.1 7631.8 7838.3 10256.1 10380.7 10396.8 10445.8 10754.2 10763.8 10764.9 10768.6 38617.6 38867.8 38967.2 38978.0 38982.2 3242.8 3282.1 3291.8 3586.0 3918.7 29816.0 30123.4 30360.7 30472.2 30712.5 3677.6 3693.2 3750.5 3750.6 3794.1 263168.0 264073.0 264720.0 265120.0 266555.0 51346.0 52335.0 57655.4 57928.0 58455.7 59305.7 59392.7 59508.0 59549.4 59832.0 14297.9 14475.5 14483.1 14487.9 14502.5 11050.8 11113.6 11142.0 11148.6 11182.2 19304.1 19599.9 19604.4 19616.5 19664.7 7936.2 7943.8 7976.6 8027.4 8053.7 913.8 965.1 1026.8 1052.4 1054.9 27039.7 27688.7 27741.9 28179.6 28244.2 1045.3 1090.0 1096.7 1135.2 1165.7 13257.0 14033.7 14148.7 14189.8 14278.6 707119.0 731480.0 732622.0 734066.0 735774.0 57568.4 58260.7 58278.7 58286.4 58459.0 1382.4 1394.7 1395.5 1395.8 1396.2 29377.4 30654.0 30743.0 30864.0 31203.2 46161.0 46653.8 46670.8 46694.8 46700.1 275677.0 276335.0 277624.0 279262.0 301860.0 27263.5 31717.2 31734.0 32124.0 32424.7 42063.6 43092.6 43110.8 43396.6 43930.6 36669.4 36934.8 37272.4 37399.6 37958.4 30426.2 36450.5 40025.2 40598.2 42003.4 36054.6 36672.0 36746.8 37192.4 37623.2 32292.0 37587.8 37608.4 39212.6 39406.4 25440.2 26502.3 28121.7 28183.2 28218.2 16:01:13 INFO - 2015-11-24 16:01:13,973 DEBUG : BROWSER_OUTPUT: 16:01:13 INFO - 2015-11-24 16:01:13,973 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:28033.93 Median:359.11 stddev:85587.74 (23833.4%) stddev-sans-first:85802.60 16:01:13 INFO - 2015-11-24 16:01:13,974 DEBUG : BROWSER_OUTPUT: Values: 355.9 358.2 360.0 363.0 364.9 14164.0 14293.1 16365.7 16696.2 17400.6 13259.1 14268.2 15810.5 16576.0 16677.3 5289.1 5396.5 5404.9 5407.7 5459.0 3989.2 4105.6 5352.7 5405.3 5874.8 6023.3 6027.2 6033.1 6065.4 6094.2 5536.3 5645.0 5657.1 5675.4 6055.0 4994.7 5032.2 5072.5 5212.1 5213.8 11569.4 11592.5 11820.7 11832.5 12450.6 1974.5 1984.9 2024.2 2092.0 2119.1 9329.9 9532.7 9577.2 9857.9 9873.0 1827.2 1875.4 1931.5 1973.9 1975.0 58586.0 61049.7 62249.4 62671.0 63143.4 10250.9 10313.1 10338.8 10342.2 10391.4 13431.1 13437.3 13454.5 13454.8 13460.8 7247.9 7332.7 7371.5 7389.2 7482.3 6986.2 7097.0 7384.1 7439.9 7456.4 4447.2 4517.5 4530.9 4565.1 4567.4 1645.4 1680.1 1680.9 1695.1 1767.3 901.6 916.1 967.3 1040.0 1069.6 15572.6 16626.0 16887.9 17183.5 17276.2 898.5 992.3 1012.2 1033.1 1036.8 9408.8 9488.5 9530.1 9545.2 9648.7 502594.0 513926.0 527245.0 535155.0 536605.0 75375.6 79377.0 80755.6 80828.0 81429.2 1143.1 1154.7 1157.6 1162.8 1177.8 14589.5 14751.9 14754.0 14966.3 15107.3 34887.5 34919.7 34928.3 35157.5 35683.1 45791.0 48284.3 48318.0 48362.3 49010.3 9599.1 9725.8 9727.8 9760.5 9821.6 16533.6 16677.7 17115.3 17445.8 17466.9 10703.8 10798.9 12092.5 13508.9 13590.3 13894.9 14465.8 14522.6 14880.1 14980.0 11797.8 11802.2 12078.3 14126.3 14587.2 9359.3 9668.4 9757.5 9759.9 9791.2 9831.3 10898.9 14471.0 14626.0 15200.5 16:01:13 INFO - 2015-11-24 16:01:13,975 DEBUG : BROWSER_OUTPUT: 16:01:13 INFO - 2015-11-24 16:01:13,975 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5095.78 Median:6055.23 stddev:2582.13 (42.6%) stddev-sans-first:2573.82 16:01:13 INFO - 2015-11-24 16:01:13,976 DEBUG : BROWSER_OUTPUT: Values: 1326.3 1696.4 1718.6 1746.1 1753.4 6744.6 6914.6 7030.5 7037.3 7039.6 7222.1 7280.5 7293.3 7314.9 7329.8 2179.0 2197.6 2199.2 2199.8 2200.2 2190.1 2197.1 2268.1 2269.4 2270.4 2157.1 2183.9 2186.8 2195.8 2198.3 2195.0 2205.8 2219.1 2219.9 2220.9 2203.6 2211.2 2213.3 2213.4 2215.4 6336.2 6512.6 7208.2 7240.7 7242.8 4406.6 4482.0 4484.6 4485.5 4498.5 2880.1 2894.6 2978.4 2985.5 3001.8 1006.1 1014.1 1015.2 1040.8 1041.3 9750.8 9849.4 9870.5 9875.5 9891.3 4023.6 4117.1 4148.1 4157.8 4179.7 8495.4 8519.7 8528.4 8608.1 8609.2 4553.4 4555.1 4601.0 4606.4 4607.3 4165.5 4180.5 4195.8 4201.4 4202.4 3391.7 3429.4 3434.0 3436.0 3436.3 1149.7 1175.2 1178.5 1181.3 1182.8 1012.0 1052.0 1071.6 1178.0 1326.7 6734.9 6840.1 6885.4 6885.4 6890.4 478.8 479.9 483.0 486.9 489.6 4943.3 5451.0 5514.2 5515.8 5518.7 7598.4 8320.2 8333.7 8365.5 8442.5 8245.2 8309.4 8334.2 8340.3 8341.4 6359.8 6573.4 6631.3 6638.9 6645.5 6670.3 6727.7 6774.3 6830.5 6832.8 7709.3 7709.6 7951.4 7959.6 7971.1 7936.3 7979.0 8121.0 8127.6 8134.8 6457.4 6500.4 6510.2 6521.6 6524.1 7127.5 7174.1 7175.9 7190.5 7208.9 6500.0 6611.9 6632.2 6719.1 6752.4 6687.5 6696.2 6718.6 6819.3 6836.7 6482.3 6500.4 6541.7 6564.0 6576.0 5922.5 5946.1 5956.1 5960.3 5961.1 6036.9 6073.5 6095.7 6099.8 6104.4 16:01:13 INFO - 2015-11-24 16:01:13,976 DEBUG : BROWSER_OUTPUT: 16:01:13 INFO - 2015-11-24 16:01:13,976 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:5286.27 Median:6008.47 stddev:1601.74 (26.7%) stddev-sans-first:1562.07 16:01:13 INFO - 2015-11-24 16:01:13,976 DEBUG : BROWSER_OUTPUT: Values: 309.7 314.5 323.6 327.5 331.2 5864.1 5907.4 5987.2 6001.9 6007.5 5769.7 5861.3 5869.8 5897.4 5922.3 4386.4 4448.0 4572.1 4582.2 4586.6 4448.8 4539.9 4545.2 4551.4 4554.3 4466.8 4473.7 4479.6 4481.2 4487.7 4478.4 4484.4 4486.5 4493.4 4494.5 3820.4 3894.0 3898.5 3901.7 3908.0 5653.5 5656.7 5668.7 5683.3 5686.9 5238.3 5238.9 5248.2 5248.6 5249.4 6005.6 6110.4 6182.9 6281.7 6289.3 4391.2 4401.4 4430.0 4430.8 4433.1 6501.6 6507.3 6516.0 6519.0 6521.2 4429.3 4511.6 4512.3 4512.8 4529.9 4555.7 4564.0 4569.2 4571.0 4584.9 5255.0 5255.6 5266.5 5268.1 5270.1 6303.8 6311.9 6316.7 6318.8 6321.6 1593.2 1599.8 1626.8 1628.2 1631.8 1084.7 1086.7 1091.7 1094.7 1095.1 6168.4 6169.8 6177.7 6180.5 6181.5 6490.2 6491.4 6492.0 6499.5 6529.7 6086.1 6181.8 6193.1 6194.8 6201.5 3505.6 3528.6 3537.9 3538.8 3544.0 6788.7 6796.4 6838.8 6842.0 6862.0 6655.8 6699.1 6700.3 6708.7 6720.9 6703.9 6908.4 6918.9 6927.8 6931.1 6340.9 6385.8 6460.8 6538.2 6569.3 6365.1 6402.9 6419.3 6425.4 6451.5 6767.4 6829.5 6841.4 6871.7 6875.0 4403.0 4433.6 4438.9 4440.5 4445.4 6548.2 6559.5 6559.8 6565.0 6565.4 6381.8 6388.0 6389.6 6390.2 6393.9 6260.8 6354.8 6355.7 6361.5 6365.1 6229.0 6229.3 6231.8 6237.7 6247.4 6362.0 6367.6 6374.4 6377.5 6398.4 6009.5 6048.6 6084.8 6119.8 6155.4 16:01:13 INFO - 2015-11-24 16:01:13,976 DEBUG : BROWSER_OUTPUT: 16:01:13 INFO - 2015-11-24 16:01:13,976 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:13495.62 Median:46213.38 stddev:15470.88 (33.5%) stddev-sans-first:15484.66 16:01:13 INFO - 2015-11-24 16:01:13,977 DEBUG : BROWSER_OUTPUT: Values: 746.7 764.0 771.1 803.4 824.4 13773.9 13817.0 13960.8 14020.1 14021.1 13015.7 13196.7 13226.1 13230.3 13234.5 674.8 677.7 677.8 805.8 820.8 678.4 806.5 815.5 818.0 821.5 856.5 864.2 864.7 864.8 865.4 854.2 854.3 855.5 855.7 862.1 519.4 524.0 609.6 614.8 618.0 13052.0 13152.4 13161.7 13196.9 13198.1 11676.0 11787.4 11979.2 12163.1 12392.4 9937.5 10178.2 10319.2 10389.2 10494.2 3545.1 3556.9 3563.1 3620.1 3665.1 46201.8 46225.0 46364.8 46502.8 46761.1 10052.7 10206.8 10247.4 10259.9 10297.8 18084.9 18254.2 18290.2 18307.4 18318.3 7467.0 7472.7 7588.2 7680.0 7773.7 4208.1 4240.3 4261.8 4278.0 4308.5 3042.7 3047.8 3052.1 3052.4 3057.5 528.7 532.1 543.6 546.9 551.4 601.8 627.1 646.2 662.7 663.6 8221.0 8430.1 8763.6 8783.1 9075.0 443.8 490.7 496.4 511.3 644.5 3737.3 3802.7 3813.2 3871.3 4052.1 52641.0 52726.7 52829.7 53247.0 54223.0 48623.5 49105.3 49235.0 50095.0 50446.2 45707.3 46049.0 46305.1 46360.5 46560.8 8528.4 8533.7 8553.2 8564.1 8762.7 34843.3 35856.8 36011.1 36111.0 36126.3 43594.8 44873.8 45084.0 45499.5 45726.8 9678.5 9866.4 10014.4 10308.4 10523.5 11287.2 11462.5 11501.6 11653.3 11669.3 10509.9 10761.7 10769.6 10835.5 10866.2 10732.7 10960.6 10967.9 11360.5 11382.5 10725.4 10854.3 11013.8 11466.5 11502.5 9109.0 9119.0 9304.3 9476.3 9481.9 8606.8 9142.3 9328.6 9330.7 9352.6 16:01:13 INFO - 2015-11-24 16:01:13,978 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 16:01:13 INFO - 2015-11-24 16:01:13,978 DEBUG : BROWSER_OUTPUT: 16:01:14 INFO - 2015-11-24 16:01:14,761 INFO : Browser exited with error code: 0 16:01:14 INFO - 2015-11-24 16:01:14,780 INFO : Completed test dromaeo_css (00:18:34) 16:01:14 INFO - 2015-11-24 16:01:14,780 INFO : Starting test kraken 16:01:14 INFO - 2015-11-24 16:01:14,780 DEBUG : operating with platform_type : linux_ 16:01:14 INFO - 2015-11-24 16:01:14,780 INFO : Initialising browser for kraken test... 16:01:14 INFO - 2015-11-24 16:01:14,787 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpfBqxpy/profile http://localhost:35871/getInfo.html 16:01:18 INFO - 2015-11-24 16:01:18,994 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 16:01:18 INFO - 2015-11-24 16:01:18,994 DEBUG : BROWSER_OUTPUT: colorDepth:24 16:01:18 INFO - 2015-11-24 16:01:18,994 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 16:01:18 INFO - 2015-11-24 16:01:18,994 DEBUG : BROWSER_OUTPUT: __metrics 16:01:19 INFO - 2015-11-24 16:01:19,123 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 16:01:20 INFO - 2015-11-24 16:01:20,607 INFO : Browser initialized. 16:01:20 INFO - 2015-11-24 16:01:20,608 INFO : Running cycle 1/1 for kraken test... 16:01:20 INFO - 2015-11-24 16:01:20,608 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpfBqxpy/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 16:01:32 INFO - 2015-11-24 16:01:32,380 DEBUG : BROWSER_OUTPUT: RSS: Main: 140460032 16:01:32 INFO - 2015-11-24 16:01:32,381 DEBUG : BROWSER_OUTPUT: 16:01:34 INFO - 2015-11-24 16:01:34,820 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:35871/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:35871/tests/kraken/driver.html?testName=audio-beat-detection) 16:01:35 INFO - 2015-11-24 16:01:35,410 DEBUG : BROWSER_OUTPUT: RSS: Main: 178290688 16:01:35 INFO - 2015-11-24 16:01:35,410 DEBUG : BROWSER_OUTPUT: 16:01:37 INFO - 2015-11-24 16:01:37,967 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:35871/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:35871/tests/kraken/driver.html?testName=audio-dft) 16:01:38 INFO - 2015-11-24 16:01:38,533 DEBUG : BROWSER_OUTPUT: RSS: Main: 164925440 16:01:38 INFO - 2015-11-24 16:01:38,534 DEBUG : BROWSER_OUTPUT: 16:01:41 INFO - 2015-11-24 16:01:41,398 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:35871/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:35871/tests/kraken/driver.html?testName=audio-fft) 16:01:41 INFO - 2015-11-24 16:01:41,951 DEBUG : BROWSER_OUTPUT: RSS: Main: 151810048 16:01:41 INFO - 2015-11-24 16:01:41,951 DEBUG : BROWSER_OUTPUT: 16:01:43 INFO - 2015-11-24 16:01:43,944 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:35871/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:35871/tests/kraken/driver.html?testName=audio-oscillator) 16:01:44 INFO - 2015-11-24 16:01:44,506 DEBUG : BROWSER_OUTPUT: RSS: Main: 154304512 16:01:44 INFO - 2015-11-24 16:01:44,506 DEBUG : BROWSER_OUTPUT: 16:01:46 INFO - 2015-11-24 16:01:46,673 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:35871/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:35871/tests/kraken/driver.html?testName=imaging-gaussian-blur) 16:01:47 INFO - 2015-11-24 16:01:47,239 DEBUG : BROWSER_OUTPUT: RSS: Main: 155103232 16:01:47 INFO - 2015-11-24 16:01:47,239 DEBUG : BROWSER_OUTPUT: 16:01:50 INFO - 2015-11-24 16:01:50,139 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:35871/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:35871/tests/kraken/driver.html?testName=imaging-darkroom) 16:01:50 INFO - 2015-11-24 16:01:50,712 DEBUG : BROWSER_OUTPUT: RSS: Main: 157368320 16:01:50 INFO - 2015-11-24 16:01:50,712 DEBUG : BROWSER_OUTPUT: 16:01:54 INFO - 2015-11-24 16:01:54,098 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:35871/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:35871/tests/kraken/driver.html?testName=imaging-desaturate) 16:01:54 INFO - 2015-11-24 16:01:54,671 DEBUG : BROWSER_OUTPUT: RSS: Main: 158003200 16:01:54 INFO - 2015-11-24 16:01:54,671 DEBUG : BROWSER_OUTPUT: 16:01:57 INFO - 2015-11-24 16:01:57,434 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:35871/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:35871/tests/kraken/driver.html?testName=json-parse-financial) 16:01:58 INFO - 2015-11-24 16:01:58,008 DEBUG : BROWSER_OUTPUT: RSS: Main: 157704192 16:01:58 INFO - 2015-11-24 16:01:58,008 DEBUG : BROWSER_OUTPUT: 16:01:59 INFO - 2015-11-24 16:01:59,596 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:35871/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:35871/tests/kraken/driver.html?testName=json-stringify-tinderbox) 16:02:00 INFO - 2015-11-24 16:02:00,158 DEBUG : BROWSER_OUTPUT: RSS: Main: 167522304 16:02:00 INFO - 2015-11-24 16:02:00,158 DEBUG : BROWSER_OUTPUT: 16:02:01 INFO - 2015-11-24 16:02:01,977 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:35871/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:35871/tests/kraken/driver.html?testName=stanford-crypto-aes) 16:02:02 INFO - 2015-11-24 16:02:02,578 DEBUG : BROWSER_OUTPUT: RSS: Main: 166416384 16:02:02 INFO - 2015-11-24 16:02:02,579 DEBUG : BROWSER_OUTPUT: 16:02:04 INFO - 2015-11-24 16:02:04,630 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:35871/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:35871/tests/kraken/driver.html?testName=stanford-crypto-ccm) 16:02:05 INFO - 2015-11-24 16:02:05,199 DEBUG : BROWSER_OUTPUT: RSS: Main: 172216320 16:02:05 INFO - 2015-11-24 16:02:05,199 DEBUG : BROWSER_OUTPUT: 16:02:07 INFO - 2015-11-24 16:02:07,634 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:35871/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:35871/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 16:02:08 INFO - 2015-11-24 16:02:08,215 DEBUG : BROWSER_OUTPUT: RSS: Main: 180953088 16:02:08 INFO - 2015-11-24 16:02:08,215 DEBUG : BROWSER_OUTPUT: 16:02:10 INFO - 2015-11-24 16:02:10,759 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:35871/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:35871/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 16:02:11 INFO - 2015-11-24 16:02:11,328 DEBUG : BROWSER_OUTPUT: RSS: Main: 178782208 16:02:11 INFO - 2015-11-24 16:02:11,328 DEBUG : BROWSER_OUTPUT: 16:02:12 INFO - 2015-11-24 16:02:12,981 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:35871/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:35871/tests/kraken/driver.html?testName=ai-astar) 16:02:13 INFO - 2015-11-24 16:02:13,239 DEBUG : BROWSER_OUTPUT: RSS: Main: 237367296 16:02:13 INFO - 2015-11-24 16:02:13,240 DEBUG : BROWSER_OUTPUT: 16:02:13 INFO - 2015-11-24 16:02:13,240 DEBUG : BROWSER_OUTPUT: __start_tp_report 16:02:13 INFO - 2015-11-24 16:02:13,240 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 16:02:13 INFO - 2015-11-24 16:02:13,240 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 16:02:13 INFO - 2015-11-24 16:02:13,240 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 16:02:13 INFO - 2015-11-24 16:02:13,240 DEBUG : BROWSER_OUTPUT: |0;ai-astar;109;111;105;110;111;110;100;110;108;109 16:02:13 INFO - 2015-11-24 16:02:13,240 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;145;123;148;173;125;147;147;124;163;123 16:02:13 INFO - 2015-11-24 16:02:13,240 DEBUG : BROWSER_OUTPUT: |2;audio-dft;161;161;160;162;161;161;161;162;161;163 16:02:13 INFO - 2015-11-24 16:02:13,240 DEBUG : BROWSER_OUTPUT: |3;audio-fft;72;73;78;93;70;70;71;112;89;73 16:02:13 INFO - 2015-11-24 16:02:13,240 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;93;93;137;93;92;93;133;93;92;134 16:02:13 INFO - 2015-11-24 16:02:13,240 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;110;109;109;109;109;109;109;109;110;109 16:02:13 INFO - 2015-11-24 16:02:13,240 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;146;146;146;146;146;146;146;151;145;145 16:02:13 INFO - 2015-11-24 16:02:13,241 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;95;96;96;95;96;97;96;95;97;95 16:02:13 INFO - 2015-11-24 16:02:13,241 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;59;63;60;59;60;59;59;59;60;58 16:02:13 INFO - 2015-11-24 16:02:13,241 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;69;69;69;69;69;69;69;69;72;69 16:02:13 INFO - 2015-11-24 16:02:13,241 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;88;85;86;85;86;85;85;84;85;84 16:02:13 INFO - 2015-11-24 16:02:13,241 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;127;123;126;123;114;116;124;132;131;116 16:02:13 INFO - 2015-11-24 16:02:13,241 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;139;140;150;149;148;140;152;156;154;139 16:02:13 INFO - 2015-11-24 16:02:13,241 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;65;67;67;66;65;65;67;66;65;65 16:02:13 INFO - 2015-11-24 16:02:13,241 DEBUG : BROWSER_OUTPUT: __end_tp_report 16:02:13 INFO - 2015-11-24 16:02:13,241 DEBUG : BROWSER_OUTPUT: __start_cc_report 16:02:13 INFO - 2015-11-24 16:02:13,241 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,929 16:02:13 INFO - 2015-11-24 16:02:13,241 DEBUG : BROWSER_OUTPUT: __end_cc_report 16:02:13 INFO - 2015-11-24 16:02:13,241 DEBUG : BROWSER_OUTPUT: __startTimestamp1448409733234__endTimestamp 16:02:13 INFO - 2015-11-24 16:02:13,241 DEBUG : BROWSER_OUTPUT: 16:02:13 INFO - 2015-11-24 16:02:13,242 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 16:02:13 INFO - 2015-11-24 16:02:13,242 DEBUG : BROWSER_OUTPUT: Number of tests: 14 16:02:13 INFO - 2015-11-24 16:02:13,242 DEBUG : BROWSER_OUTPUT: 16:02:13 INFO - 2015-11-24 16:02:13,242 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:108.30 Median:110.00 stddev:3.40 (3.1%) stddev-sans-first:3.60 16:02:13 INFO - 2015-11-24 16:02:13,242 DEBUG : BROWSER_OUTPUT: Values: 109.0 111.0 105.0 110.0 111.0 110.0 100.0 110.0 108.0 109.0 16:02:13 INFO - 2015-11-24 16:02:13,242 DEBUG : BROWSER_OUTPUT: 16:02:13 INFO - 2015-11-24 16:02:13,242 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:141.80 Median:147.00 stddev:17.74 (12.1%) stddev-sans-first:18.78 16:02:13 INFO - 2015-11-24 16:02:13,242 DEBUG : BROWSER_OUTPUT: Values: 145.0 123.0 148.0 173.0 125.0 147.0 147.0 124.0 163.0 123.0 16:02:13 INFO - 2015-11-24 16:02:13,242 DEBUG : BROWSER_OUTPUT: 16:02:13 INFO - 2015-11-24 16:02:13,242 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:161.30 Median:161.00 stddev:0.82 (0.5%) stddev-sans-first:0.87 16:02:13 INFO - 2015-11-24 16:02:13,242 DEBUG : BROWSER_OUTPUT: Values: 161.0 161.0 160.0 162.0 161.0 161.0 161.0 162.0 161.0 163.0 16:02:13 INFO - 2015-11-24 16:02:13,242 DEBUG : BROWSER_OUTPUT: 16:02:13 INFO - 2015-11-24 16:02:13,242 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:80.10 Median:73.00 stddev:13.83 (18.9%) stddev-sans-first:14.35 16:02:13 INFO - 2015-11-24 16:02:13,242 DEBUG : BROWSER_OUTPUT: Values: 72.0 73.0 78.0 93.0 70.0 70.0 71.0 112.0 89.0 73.0 16:02:13 INFO - 2015-11-24 16:02:13,242 DEBUG : BROWSER_OUTPUT: 16:02:13 INFO - 2015-11-24 16:02:13,242 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:105.30 Median:93.00 stddev:20.29 (21.8%) stddev-sans-first:21.03 16:02:13 INFO - 2015-11-24 16:02:13,243 DEBUG : BROWSER_OUTPUT: Values: 93.0 93.0 137.0 93.0 92.0 93.0 133.0 93.0 92.0 134.0 16:02:13 INFO - 2015-11-24 16:02:13,243 DEBUG : BROWSER_OUTPUT: 16:02:13 INFO - 2015-11-24 16:02:13,243 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:109.20 Median:109.00 stddev:0.42 (0.4%) stddev-sans-first:0.33 16:02:13 INFO - 2015-11-24 16:02:13,243 DEBUG : BROWSER_OUTPUT: Values: 110.0 109.0 109.0 109.0 109.0 109.0 109.0 109.0 110.0 109.0 16:02:13 INFO - 2015-11-24 16:02:13,243 DEBUG : BROWSER_OUTPUT: 16:02:13 INFO - 2015-11-24 16:02:13,243 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:146.30 Median:146.00 stddev:1.70 (1.2%) stddev-sans-first:1.80 16:02:13 INFO - 2015-11-24 16:02:13,243 DEBUG : BROWSER_OUTPUT: Values: 146.0 146.0 146.0 146.0 146.0 146.0 146.0 151.0 145.0 145.0 16:02:13 INFO - 2015-11-24 16:02:13,243 DEBUG : BROWSER_OUTPUT: 16:02:13 INFO - 2015-11-24 16:02:13,243 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:95.80 Median:96.00 stddev:0.79 (0.8%) stddev-sans-first:0.78 16:02:13 INFO - 2015-11-24 16:02:13,243 DEBUG : BROWSER_OUTPUT: Values: 95.0 96.0 96.0 95.0 96.0 97.0 96.0 95.0 97.0 95.0 16:02:13 INFO - 2015-11-24 16:02:13,243 DEBUG : BROWSER_OUTPUT: 16:02:13 INFO - 2015-11-24 16:02:13,243 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:59.60 Median:59.50 stddev:1.35 (2.3%) stddev-sans-first:1.41 16:02:13 INFO - 2015-11-24 16:02:13,243 DEBUG : BROWSER_OUTPUT: Values: 59.0 63.0 60.0 59.0 60.0 59.0 59.0 59.0 60.0 58.0 16:02:13 INFO - 2015-11-24 16:02:13,243 DEBUG : BROWSER_OUTPUT: 16:02:13 INFO - 2015-11-24 16:02:13,243 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:69.30 Median:69.00 stddev:0.95 (1.4%) stddev-sans-first:1.00 16:02:13 INFO - 2015-11-24 16:02:13,244 DEBUG : BROWSER_OUTPUT: Values: 69.0 69.0 69.0 69.0 69.0 69.0 69.0 69.0 72.0 69.0 16:02:13 INFO - 2015-11-24 16:02:13,244 DEBUG : BROWSER_OUTPUT: 16:02:13 INFO - 2015-11-24 16:02:13,244 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:85.30 Median:85.00 stddev:1.16 (1.4%) stddev-sans-first:0.71 16:02:13 INFO - 2015-11-24 16:02:13,244 DEBUG : BROWSER_OUTPUT: Values: 88.0 85.0 86.0 85.0 86.0 85.0 85.0 84.0 85.0 84.0 16:02:13 INFO - 2015-11-24 16:02:13,244 DEBUG : BROWSER_OUTPUT: 16:02:13 INFO - 2015-11-24 16:02:13,244 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:123.20 Median:125.00 stddev:6.23 (5.0%) stddev-sans-first:6.46 16:02:13 INFO - 2015-11-24 16:02:13,244 DEBUG : BROWSER_OUTPUT: Values: 127.0 123.0 126.0 123.0 114.0 116.0 124.0 132.0 131.0 116.0 16:02:13 INFO - 2015-11-24 16:02:13,244 DEBUG : BROWSER_OUTPUT: 16:02:13 INFO - 2015-11-24 16:02:13,244 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:146.70 Median:149.50 stddev:6.62 (4.4%) stddev-sans-first:6.41 16:02:13 INFO - 2015-11-24 16:02:13,245 DEBUG : BROWSER_OUTPUT: Values: 139.0 140.0 150.0 149.0 148.0 140.0 152.0 156.0 154.0 139.0 16:02:13 INFO - 2015-11-24 16:02:13,245 DEBUG : BROWSER_OUTPUT: 16:02:13 INFO - 2015-11-24 16:02:13,245 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.80 Median:66.00 stddev:0.92 (1.4%) stddev-sans-first:0.93 16:02:13 INFO - 2015-11-24 16:02:13,245 DEBUG : BROWSER_OUTPUT: Values: 65.0 67.0 67.0 66.0 65.0 65.0 67.0 66.0 65.0 65.0 16:02:13 INFO - 2015-11-24 16:02:13,245 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 16:02:13 INFO - 2015-11-24 16:02:13,245 DEBUG : BROWSER_OUTPUT: 16:02:14 INFO - 2015-11-24 16:02:14,109 INFO : Browser exited with error code: 0 16:02:14 INFO - 2015-11-24 16:02:14,163 INFO : Completed test kraken (00:00:59) 16:02:14 INFO - 2015-11-24 16:02:14,163 INFO : Starting test v8_7 16:02:14 INFO - 2015-11-24 16:02:14,163 DEBUG : operating with platform_type : linux_ 16:02:14 INFO - 2015-11-24 16:02:14,163 INFO : Initialising browser for v8_7 test... 16:02:14 INFO - 2015-11-24 16:02:14,170 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpfNomTz/profile http://localhost:35871/getInfo.html 16:02:18 INFO - 2015-11-24 16:02:18,450 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 16:02:18 INFO - 2015-11-24 16:02:18,450 DEBUG : BROWSER_OUTPUT: colorDepth:24 16:02:18 INFO - 2015-11-24 16:02:18,450 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 16:02:18 INFO - 2015-11-24 16:02:18,451 DEBUG : BROWSER_OUTPUT: __metrics 16:02:18 INFO - 2015-11-24 16:02:18,627 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 16:02:19 INFO - 2015-11-24 16:02:19,940 INFO : Browser initialized. 16:02:19 INFO - 2015-11-24 16:02:19,941 INFO : Running cycle 1/1 for v8_7 test... 16:02:19 INFO - 2015-11-24 16:02:19,941 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpfNomTz/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 16:02:31 INFO - 2015-11-24 16:02:31,762 DEBUG : BROWSER_OUTPUT: RSS: Main: 140484608 16:02:31 INFO - 2015-11-24 16:02:31,763 DEBUG : BROWSER_OUTPUT: 16:02:53 INFO - 2015-11-24 16:02:53,195 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:35871/tests/v8_7/run.html (next: http://localhost:35871/tests/v8_7/run.html) 16:02:53 INFO - 2015-11-24 16:02:53,446 DEBUG : BROWSER_OUTPUT: RSS: Main: 607166464 16:02:53 INFO - 2015-11-24 16:02:53,446 DEBUG : BROWSER_OUTPUT: 16:02:53 INFO - 2015-11-24 16:02:53,446 DEBUG : BROWSER_OUTPUT: __start_tp_report 16:02:53 INFO - 2015-11-24 16:02:53,446 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 16:02:53 INFO - 2015-11-24 16:02:53,447 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 16:02:53 INFO - 2015-11-24 16:02:53,447 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 16:02:53 INFO - 2015-11-24 16:02:53,447 DEBUG : BROWSER_OUTPUT: |0;Richards;189.3580761219466 16:02:53 INFO - 2015-11-24 16:02:53,447 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;196.50225977598743 16:02:53 INFO - 2015-11-24 16:02:53,447 DEBUG : BROWSER_OUTPUT: |2;Encrypt;284.7380410022779 16:02:53 INFO - 2015-11-24 16:02:53,447 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5015 16:02:53 INFO - 2015-11-24 16:02:53,447 DEBUG : BROWSER_OUTPUT: |4;RayTrace;2016.1290322580646 16:02:53 INFO - 2015-11-24 16:02:53,448 DEBUG : BROWSER_OUTPUT: |5;Earley;789.2659826361484 16:02:53 INFO - 2015-11-24 16:02:53,448 DEBUG : BROWSER_OUTPUT: |6;Boyer;11823.529411764706 16:02:53 INFO - 2015-11-24 16:02:53,448 DEBUG : BROWSER_OUTPUT: |7;RegExp;25425 16:02:53 INFO - 2015-11-24 16:02:53,448 DEBUG : BROWSER_OUTPUT: |8;Splay;642.2607578676943 16:02:53 INFO - 2015-11-24 16:02:53,448 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4835.748792270531 16:02:53 INFO - 2015-11-24 16:02:53,448 DEBUG : BROWSER_OUTPUT: __end_tp_report 16:02:53 INFO - 2015-11-24 16:02:53,449 DEBUG : BROWSER_OUTPUT: __startTimestamp1448409773445__endTimestamp 16:02:53 INFO - 2015-11-24 16:02:53,449 DEBUG : BROWSER_OUTPUT: 16:02:53 INFO - 2015-11-24 16:02:53,449 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 16:02:53 INFO - 2015-11-24 16:02:53,449 DEBUG : BROWSER_OUTPUT: Number of tests: 10 16:02:53 INFO - 2015-11-24 16:02:53,449 DEBUG : BROWSER_OUTPUT: 16:02:53 INFO - 2015-11-24 16:02:53,449 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:189.36 Median:189.36 stddev:0.00 (0.0%) 16:02:53 INFO - 2015-11-24 16:02:53,449 DEBUG : BROWSER_OUTPUT: Values: 189.4 16:02:53 INFO - 2015-11-24 16:02:53,450 DEBUG : BROWSER_OUTPUT: 16:02:53 INFO - 2015-11-24 16:02:53,450 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:196.50 Median:196.50 stddev:0.00 (0.0%) 16:02:53 INFO - 2015-11-24 16:02:53,450 DEBUG : BROWSER_OUTPUT: Values: 196.5 16:02:53 INFO - 2015-11-24 16:02:53,450 DEBUG : BROWSER_OUTPUT: 16:02:53 INFO - 2015-11-24 16:02:53,450 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:284.74 Median:284.74 stddev:0.00 (0.0%) 16:02:53 INFO - 2015-11-24 16:02:53,450 DEBUG : BROWSER_OUTPUT: Values: 284.7 16:02:53 INFO - 2015-11-24 16:02:53,450 DEBUG : BROWSER_OUTPUT: 16:02:53 INFO - 2015-11-24 16:02:53,450 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5015.00 Median:5015.00 stddev:0.00 (0.0%) 16:02:53 INFO - 2015-11-24 16:02:53,450 DEBUG : BROWSER_OUTPUT: Values: 5015.0 16:02:53 INFO - 2015-11-24 16:02:53,450 DEBUG : BROWSER_OUTPUT: 16:02:53 INFO - 2015-11-24 16:02:53,450 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:2016.13 Median:2016.13 stddev:0.00 (0.0%) 16:02:53 INFO - 2015-11-24 16:02:53,450 DEBUG : BROWSER_OUTPUT: Values: 2016.1 16:02:53 INFO - 2015-11-24 16:02:53,451 DEBUG : BROWSER_OUTPUT: 16:02:53 INFO - 2015-11-24 16:02:53,451 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:789.27 Median:789.27 stddev:0.00 (0.0%) 16:02:53 INFO - 2015-11-24 16:02:53,451 DEBUG : BROWSER_OUTPUT: Values: 789.3 16:02:53 INFO - 2015-11-24 16:02:53,451 DEBUG : BROWSER_OUTPUT: 16:02:53 INFO - 2015-11-24 16:02:53,452 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:11823.53 Median:11823.53 stddev:0.00 (0.0%) 16:02:53 INFO - 2015-11-24 16:02:53,452 DEBUG : BROWSER_OUTPUT: Values: 11823.5 16:02:53 INFO - 2015-11-24 16:02:53,452 DEBUG : BROWSER_OUTPUT: 16:02:53 INFO - 2015-11-24 16:02:53,452 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:25425.00 Median:25425.00 stddev:0.00 (0.0%) 16:02:53 INFO - 2015-11-24 16:02:53,452 DEBUG : BROWSER_OUTPUT: Values: 25425.0 16:02:53 INFO - 2015-11-24 16:02:53,452 DEBUG : BROWSER_OUTPUT: 16:02:53 INFO - 2015-11-24 16:02:53,452 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:642.26 Median:642.26 stddev:0.00 (0.0%) 16:02:53 INFO - 2015-11-24 16:02:53,453 DEBUG : BROWSER_OUTPUT: Values: 642.3 16:02:53 INFO - 2015-11-24 16:02:53,453 DEBUG : BROWSER_OUTPUT: 16:02:53 INFO - 2015-11-24 16:02:53,453 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4835.75 Median:4835.75 stddev:0.00 (0.0%) 16:02:53 INFO - 2015-11-24 16:02:53,453 DEBUG : BROWSER_OUTPUT: Values: 4835.7 16:02:53 INFO - 2015-11-24 16:02:53,453 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 16:02:53 INFO - 2015-11-24 16:02:53,453 DEBUG : BROWSER_OUTPUT: 16:02:54 INFO - 2015-11-24 16:02:54,601 INFO : Browser exited with error code: 0 16:02:54 INFO - 2015-11-24 16:02:54,616 INFO : Completed test v8_7 (00:00:40) 16:02:54 INFO - 2015-11-24 16:02:54,920 INFO : Completed test suite (00:20:14) 16:02:54 INFO - 2015-11-24 16:02:54,920 DEBUG : Working with test: dromaeo_css 16:02:54 INFO - 2015-11-24 16:02:54,920 DEBUG : Generating results file: dromaeo_css 16:02:54 INFO - 2015-11-24 16:02:54,921 DEBUG : Working with test: kraken 16:02:54 INFO - 2015-11-24 16:02:54,921 DEBUG : Generating results file: kraken 16:02:54 INFO - 2015-11-24 16:02:54,922 INFO : javascript benchmark 16:02:54 INFO - 2015-11-24 16:02:54,922 DEBUG : Working with test: v8_7 16:02:54 INFO - 2015-11-24 16:02:54,922 DEBUG : Generating results file: v8_7 16:02:54 INFO - 2015-11-24 16:02:54,922 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 16:02:54 INFO - 2015-11-24 16:02:54,974 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,64,35]] 16:02:54 INFO - 2015-11-24 16:02:54,974 DEBUG : process_Request line: dromaeo_css 6924.40 graph.html#tests=[[72,64,35]] 16:02:54 INFO - 2015-11-24 16:02:54,974 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 16:02:55 INFO - 2015-11-24 16:02:55,013 DEBUG : process_Request line: kraken 1498.00 graph.html#tests=[[232,64,35]] 16:02:55 INFO - 2015-11-24 16:02:55,013 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 16:02:55 INFO - 2015-11-24 16:02:55,054 DEBUG : process_Request line: v8_7 19480.80 graph.html#tests=[[230,64,35]] 16:02:55 INFO - 2015-11-24 16:02:55,056 INFO : javascript benchmark 16:02:55 INFO - 2015-11-24 16:02:55,059 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3191.914748985345, 3254.0725893120434, 3278.7868788528745, 3292.440285151524, 3320.9003729888095, 5217.921731174036, 5348.625596208267, 5371.24802527646, 5419.26839876616, 5422.593305502089, 5358.410574836765, 5362.892742145154, 5375.354957405107, 5415.377231618365, 5580.609357344987, 4910.1898186799135, 4937.580305674022, 4943.629227807911, 4965.404151501825, 5063.797448102072, 5015.5486006259425, 5071.137906555894, 5087.974560127194, 5104.175465969676, 5108.259302401149, 4800.543948324921, 4872.220444728827, 4914.606831453475, 4982.277569752366, 5007.549320561149, 4965.081459929925, 4969.378827646544, 4972.552470277692, 4983.900321993576, 5019.749012549394, 4932.161532539477, 4938.38270216223, 4943.678660887067, 4949.183384741549, 4972.229304457815, 5058.54473097423, 5201.531862132426, 5209.557187639018, 5286.15421532553, 5336.17289320156, 5880.117982302646, 5881.000229960917, 5890.646561206298, 5894.204282421904, 5913.674747888907, 5700.914486282709, 5930.97034514829, 5933.970330148365, 5935.9406405935815, 5937.139114828326, 5400.135978243501, 5463.2078348639625, 5474.343078830526, 5482.890342193134, 5529.834104976857, 5978.372270911578, 5994.37059108796, 6007.729652165575, 6013.188219590387, 6058.909116363258, 5575.358833734092, 5738.397468265855, 5740.770369185269, 5746.310442746897, 5762.0, 5604.3835178130375, 5667.659940403589, 5670.886582268332, 5722.942770572241, 5795.1886735857015, 5878.2358293421585, 5883.61756485827, 5902.026165682701, 5941.376155503696, 5947.821565353046, 5739.770409183586, 5818.7672493100645, 5914.733836977346, 5923.111533269957, 5928.6146400484695, 4485.394471746337, 4517.728936263835, 4549.977250113794, 4569.2689169732685, 4584.060267645124, 4008.038070862972, 4028.0, 4029.435878976946, 4062.045419326456, 4067.613576710208, 5405.21624364465, 5596.552275817925, 5599.300087489064, 5600.747966341524, 5604.60767746262, 5795.855103622359, 5849.532037436995, 5871.3541510433815, 5877.617954832922, 5896.056630939029, 5606.243157173811, 5607.383187849333, 5610.915836262459, 5628.971855140698, 5630.60585758993, 5113.207452844741, 5146.073706732824, 5152.639315247897, 5159.2003239497935, 5206.114960456732, 5871.530277577784, 6058.0610005449225, 6060.484858787053, 6061.575689701766, 6139.171211886427, 5731.656100633975, 5808.099744539603, 5853.0635098384055, 5858.531317494675, 5862.355140934579, 6202.472789812917, 6244.375562443719, 6267.435930766253, 6276.592021518587, 6280.905786413116, 5602.0, 5812.883742325214, 5873.148393482836, 5879.647221166743, 5934.3175534814045, 5715.914261286167, 5724.685142317213, 5751.511121554715, 5835.095560188178, 5845.736941837713, 5773.942260577341, 5815.011448053926, 5837.153612726216, 5837.270341207349, 5842.678652673973, 5675.177099320493, 5780.710964451677, 5792.391798861059, 5798.043322851682, 5798.391168927371, 5374.57003439716, 5506.256655351636, 5509.834704958857, 5712.171735098471, 5730.914036289542, 5649.265595472562, 5683.8863222736145, 5685.459881311269, 5744.42555744439, 5764.365919748908, 5547.472990065938, 5645.294338207724, 5663.8867222656145, 5685.77256909719, 5704.401037890962], "unit": "ms", "name": "dojo.html", "value": 5402.372033451042}, {"lowerIsBetter": false, "replicates": [559.8768270980386, 598.1147901106362, 605.4399680295727, 622.9968850155749, 655.7704803318838, 30757.38485230294, 31534.0, 39695.60304396959, 40672.59327406725, 40774.0, 42890.78554607223, 43399.13201735971, 43482.78258608703, 43496.347554786706, 43500.3474947876, 7561.924380756177, 8680.218780309786, 8779.429337093068, 8853.380263381567, 8858.468491890475, 7478.925210747904, 7535.284148005931, 10552.525136368882, 10842.186835987293, 10845.891541084568, 10476.528556214951, 10482.0, 10483.423411712352, 10485.58057677692, 10598.099161571276, 7631.809204769869, 7838.333741631911, 10256.128229100535, 10380.740481487948, 10396.792064158712, 10445.791084178274, 10754.193435492369, 10763.83854242187, 10764.892351076467, 10768.623098191603, 38617.613823861684, 38867.8056609718, 38967.220655587014, 38978.0, 38982.22035559301, 3242.789218700777, 3282.1302354875975, 3291.835408229579, 3585.982070089633, 3918.74528155669, 29816.0, 30123.397532049454, 30360.696393036007, 30472.190976127986, 30712.53931191034, 3677.558692956862, 3693.169036966688, 3750.49368335274, 3750.587435382106, 3794.0704527390967, 263168.0, 264073.0, 264720.0, 265120.0, 266555.0, 51346.0, 52335.0, 57655.423445765846, 57928.0, 58455.70772146112, 59305.70347148237, 59392.70303648454, 59508.0, 59549.40450595525, 59832.0, 14297.928510357382, 14475.49335773264, 14483.131012139094, 14487.927560362341, 14502.492412765503, 11050.778984420267, 11113.555457781598, 11142.0, 11148.554057837759, 11182.16133789969, 19304.1313140909, 19599.902000489907, 19604.411867643994, 19616.50958726015, 19664.70502942457, 7936.166702496154, 7943.761687149395, 7976.601169941479, 8027.357811375076, 8053.677852885936, 913.8355096082636, 965.1072757699101, 1026.7843752811993, 1052.4474650808386, 1054.894510548939, 27039.729602703723, 27688.723112769017, 27741.861290693418, 28179.577306340423, 28244.15267541977, 1045.3498838776425, 1089.9564017439213, 1096.6709987004026, 1135.1769966774023, 1165.6677846813618, 13257.0, 14033.71932561343, 14148.717025659429, 14189.78715319271, 14278.643033924234, 707119.0, 731480.0, 732622.0, 734066.0, 735774.0, 57568.4243157563, 58260.70869645625, 58278.7086064567, 58286.417135828946, 58459.0, 1382.4401117547409, 1394.7071115065746, 1395.490645914234, 1395.818543589327, 1396.2460271453301, 29377.412451751272, 30654.0, 30743.0, 30864.0, 31203.219919502193, 46161.0, 46653.76673116613, 46670.76664616655, 46694.76652616851, 46700.06599867916, 275677.0, 276335.0, 277624.0, 279262.0, 301860.0, 27263.45473090567, 31717.20706982344, 31734.0, 32124.0, 32424.675753243107, 42063.57936420719, 43092.569074308856, 43110.78444607757, 43396.56603433925, 43930.56069439393, 36669.44995825118, 36934.8153259232, 37272.44091338578, 37399.62600373961, 37958.43062354122, 30426.239344016576, 36450.45324320084, 40025.199496009336, 40598.1880362397, 42003.36994945139, 36054.63945360513, 36672.0, 36746.816265919566, 37192.44211336886, 37623.2475350486, 32292.0, 37587.81206094062, 37608.43587346137, 39212.6078739209, 39406.408903867035, 25440.23679289624, 26502.337441564116, 28121.718782812728, 28183.154505364873, 28218.153455396372], "unit": "ms", "name": "ext.html", "value": 19322.367897519223}, {"lowerIsBetter": false, "replicates": [355.85409981907407, 358.22554316816246, 359.99100022499437, 363.0343286856959, 364.89600463867805, 14164.0, 14293.14241145532, 16365.672686546262, 16696.16519174041, 17400.564985875342, 13259.138156019852, 14268.215248161347, 15810.525684229491, 16576.0, 16677.332906683747, 5289.074411977898, 5396.514313711765, 5404.91892621611, 5407.729613519308, 5458.962797068564, 3989.2021595680835, 4105.630493255607, 5352.732363381835, 5405.324334458192, 5874.765009399619, 6023.337432882379, 6027.246594175728, 6033.09503574463, 6065.393460653943, 6094.207752992105, 5536.335639723239, 5645.0, 5657.09486482165, 5675.3757086720425, 6055.0, 4994.675346102492, 5032.245163225509, 5072.54347108762, 5212.087884620177, 5213.817516386946, 11569.421528923604, 11592.536298548048, 11820.70448238801, 11832.467538960767, 12450.626481205578, 1974.5063734066484, 1984.9007549622606, 2024.2206750401053, 2092.0376626751713, 2119.1417475922276, 9329.906700932972, 9532.666356677482, 9577.23382129428, 9857.852132218022, 9872.950635246778, 1827.159506626953, 1875.4186202277338, 1931.4591914264029, 1973.8815671059783, 1974.9769917667893, 58586.0, 61049.694751526404, 62249.37750622481, 62670.99999999954, 63143.36856631467, 10250.897491025144, 10313.071823535767, 10338.793224135476, 10342.172626190037, 10391.376517408828, 13431.12697674648, 13437.328133593477, 13454.52909148175, 13454.798178027337, 13460.798088028687, 7247.855042899112, 7332.670029848669, 7371.520851144658, 7389.224131466119, 7482.289182527651, 6986.16166060076, 7097.0, 7384.113906331275, 7439.85120297591, 7456.366208872307, 4447.177272204653, 4517.503074661785, 4530.864074077783, 4565.086982603492, 4567.36056952027, 1645.3500867157645, 1680.0675625027982, 1680.9411670591471, 1695.1100672146974, 1767.2754170790172, 901.6483571407157, 916.1205242966827, 967.2793768642266, 1040.0275742181084, 1069.5721711315537, 15572.610684732972, 16626.0, 16887.91556042212, 17183.484495465156, 17276.22256998438, 898.4743924803932, 992.270681049428, 1012.2054187462807, 1033.0599154769125, 1036.8335622424772, 9408.811823763486, 9488.478133702713, 9530.142287194047, 9545.188658964065, 9648.744025372673, 502594.0, 513926.0, 527245.0, 535155.0, 536605.0, 75375.62312188404, 79377.0, 80755.59622201852, 80828.0, 81429.18570814216, 1143.0512674480162, 1154.722866512031, 1157.6469176900957, 1162.7674465106843, 1177.8056620657496, 14589.489367872498, 14751.852481475047, 14754.0, 14966.251687415368, 15107.32017059257, 34887.476687849194, 34919.65080349164, 34928.30143397067, 35157.47263790994, 35683.10792230215, 45791.0, 48284.27573586329, 48318.0, 48362.274565882246, 49010.26484602663, 9599.088086631758, 9725.756856078655, 9727.756806079904, 9760.46317452547, 9821.558029888529, 16533.58666033359, 16677.666446670755, 17115.315387384366, 17445.82554174493, 17466.91266543659, 10703.785924281627, 10798.946005269923, 12092.516299347928, 13508.86491135076, 13590.32048397596, 13894.930525347309, 14465.783013254599, 14522.564323070324, 14880.107193568421, 14980.0, 11797.823032654345, 11802.173847830913, 12078.275303481467, 14126.293685315488, 14587.197704126374, 9359.251259899056, 9668.371555848847, 9757.463339516395, 9759.9024009759, 9791.167750741266, 9831.262655300738, 10898.85800217374, 14471.0, 14626.0, 15200.46798362052], "unit": "ms", "name": "jquery.html", "value": 8663.576103116155}, {"lowerIsBetter": false, "replicates": [1326.2904346174798, 1696.4486541873891, 1718.5531761741952, 1746.0833062642112, 1753.3600235913896, 6744.629045402501, 6914.619695916723, 7030.507864449491, 7037.261087585794, 7039.577625342483, 7222.061132052826, 7280.453965952562, 7293.307135822089, 7314.926850731491, 7329.780106596811, 2178.9564208715856, 2197.571473562656, 2199.2412617646964, 2199.8350123740784, 2200.1639377036704, 2190.058274941782, 2197.121151539389, 2268.0700912625744, 2269.387265438331, 2270.3529494094105, 2157.072458842697, 2183.9126434942664, 2186.7703891091364, 2195.82433405328, 2198.329509499602, 2194.9890250548806, 2205.7683943185893, 2219.0569008171624, 2219.9001044953015, 2220.911163553464, 2203.6474164133824, 2211.2150186683657, 2213.3249358945513, 2213.435573928654, 2215.4461384653837, 6336.176297081396, 6512.641804700739, 7208.171060328077, 7240.746573869942, 7242.78271651846, 4406.5593440655675, 4482.0, 4484.596386325246, 4485.506594274627, 4498.460184777848, 2880.0783749200264, 2894.5658151277266, 2978.3894301668106, 2985.5223164293607, 3001.7748668849704, 1006.139750513308, 1014.122783792022, 1015.2334987084778, 1040.8282633365486, 1041.2555023158477, 9750.804983900282, 9849.359791613522, 9870.45712485813, 9875.506224688737, 9891.258155638285, 4023.5976402360116, 4117.114820313647, 4148.128892932457, 4157.771322577227, 4179.707420480538, 8495.36284778644, 8519.659213631508, 8528.445651032664, 8608.139186081467, 8609.225169734755, 4553.385292985471, 4555.134524440346, 4600.95399046012, 4606.378138951266, 4607.308903664477, 4165.479315085614, 4180.540140584533, 4195.790210489525, 4201.411802347674, 4202.432671589297, 3391.7117045050954, 3429.416999110157, 3434.0384692286198, 3436.037909385376, 3436.329915666421, 1149.747055647756, 1175.2243519277235, 1178.452019810792, 1181.3207405741732, 1182.7870983223102, 1011.9797604047877, 1052.032130439997, 1071.64100026492, 1178.0, 1326.7346530693899, 6734.8989765153565, 6840.144981877265, 6885.414739747178, 6885.449164066863, 6890.44876409886, 478.810869706464, 479.8752324395682, 482.97826597803186, 486.85151028936514, 489.6499003212649, 4943.307936888838, 5450.972745136328, 5514.172874068921, 5515.806946756925, 5518.696471694015, 7598.430117741192, 8320.209580089882, 8333.708320208763, 8365.498070115813, 8442.535660538606, 8245.216704413071, 8309.37679674027, 8334.249917507454, 8340.29107525855, 8341.374396920255, 6359.8092057238355, 6573.375529324707, 6631.33686631333, 6638.900416493757, 6645.501587380966, 6670.266270710315, 6727.663616819042, 6774.254831968578, 6830.487713421414, 6832.795016149524, 7709.267619576131, 7709.575973321297, 7951.3638908886, 7959.5622240775, 7971.12317645047, 7936.325412340016, 7979.0425148982495, 8121.0, 8127.593620319079, 8134.837303253784, 6457.386548278094, 6500.382463665944, 6510.18622672166, 6521.608703477807, 6524.119243902012, 7127.536710113826, 7174.067371241706, 7175.892361614684, 7190.460715446257, 7208.8918666219, 6499.992501162327, 6611.900821487586, 6632.2372927114, 6719.059331693469, 6752.358525940028, 6687.465002799667, 6696.1629796275465, 6718.596884186964, 6819.318068193141, 6836.726530938707, 6482.2869484357625, 6500.447461965597, 6541.738330466728, 6564.0, 6575.967120164369, 5922.466977972003, 5946.13781001761, 5956.106584012259, 5960.284765828128, 5961.135635332939, 6036.9094463582205, 6073.544484163794, 6095.725692343766, 6099.84750381244, 6104.389561044038], "unit": "ms", "name": "mootools.html", "value": 4169.682143324986}, {"lowerIsBetter": false, "replicates": [309.6578280999497, 314.49366519902935, 323.5712680698075, 327.52181814550755, 331.241457063325, 5864.091065884794, 5907.438793314634, 5987.191729116568, 6001.879962400761, 6007.489363404105, 5769.740361683724, 5861.267341582302, 5869.794557190499, 5897.439743224398, 5922.289325280973, 4386.40783494229, 4447.9555204448025, 4572.0627271409285, 4582.198115329804, 4586.633069354443, 4448.755318457484, 4539.931901021488, 4545.159145558066, 4551.4083169188125, 4554.294084416921, 4466.754328511931, 4473.686841921067, 4479.574440428154, 4481.2381895077915, 4487.708298960557, 4478.350639157304, 4484.372187893698, 4486.4840543337605, 4493.393391892086, 4494.528074552158, 3820.3887378019663, 3894.0, 3898.4737060496755, 3901.7073719471155, 3908.042529580271, 5653.547716182696, 5656.688882111483, 5668.659880407189, 5683.3464151622675, 5686.943130568683, 5238.345206849144, 5238.92141617876, 5248.21276808478, 5248.580113590903, 5249.422563518048, 6005.609635373687, 6110.3889611038985, 6182.938170618326, 6281.748730050793, 6289.339619339949, 4391.209582275189, 4401.427814384142, 4429.977850110761, 4430.844920427802, 4433.069055498349, 6501.609903405763, 6507.284198738135, 6516.0, 6519.0221466779885, 6521.152250207443, 4429.335599660077, 4511.593956543861, 4512.323151527297, 4512.75179865104, 4529.932051019237, 4555.749433781108, 4564.0, 4569.1547063793305, 4570.954290457119, 4584.862454126382, 5255.0, 5255.5532779713385, 5266.473352664703, 5268.130758424893, 5270.077736396115, 6303.779367722108, 6311.90532142009, 6316.747330106836, 6318.778842740482, 6321.589096708699, 1593.1635891157234, 1599.808023037243, 1626.8047834259964, 1628.2184551415387, 1631.8041834979879, 1084.6854412220368, 1086.663134428314, 1091.748897753521, 1094.6934858239706, 1095.1074873977682, 6168.444839964424, 6169.784057558054, 6177.722002509898, 6180.505559555225, 6181.505479561624, 6490.156279683705, 6491.350864913471, 6492.0, 6499.480041596661, 6529.673516324165, 6086.117512960596, 6181.84545386369, 6193.1329613854095, 6194.752209911643, 6201.534884883562, 3505.5618047744033, 3528.647135286451, 3537.893863184109, 3538.7522873398616, 3544.025393016889, 6788.694508747019, 6796.422304104207, 6838.829029274209, 6842.0, 6862.039314495974, 6655.800325990228, 6699.062131301622, 6700.262971073178, 6708.664566771642, 6720.865582688319, 6703.865922681616, 6908.378245957888, 6918.861622767517, 6927.792166235021, 6931.064306318583, 6340.9048864268, 6385.808425747235, 6460.806175814733, 6538.1827271591055, 6569.343065693583, 6365.077063825626, 6402.935970640234, 6419.325970773001, 6425.389587989133, 6451.451626611791, 6767.35710107539, 6829.453643708392, 6841.3842754152365, 6871.656417179221, 6874.9656251718425, 4402.977985110054, 4433.556644335541, 4438.889027774331, 4440.533743956838, 4445.37764712947, 6548.214214294125, 6559.508036897157, 6559.8032059038305, 6565.048068030204, 6565.409113179837, 6381.8085457436355, 6388.041793730978, 6389.584676995981, 6390.233172019387, 6393.87212255743, 6260.843478913063, 6354.777582784581, 6355.682215889279, 6361.491080713439, 6365.14070600463, 6228.968855155877, 6229.283632382334, 6231.813045608639, 6237.7193026314835, 6247.406496382836, 6362.04569314588, 6367.586106903036, 6374.426301632875, 6377.521685873671, 6398.360163983564, 6009.45914867664, 6048.60684055535, 6084.817455476343, 6119.84700382494, 6155.35368786271], "unit": "ms", "name": "prototype.html", "value": 4762.970981091441}, {"lowerIsBetter": false, "replicates": [746.73117677636, 763.9503432276903, 771.0901136658744, 803.4351050740928, 824.4352618456358, 13773.93113034436, 13817.0, 13960.790588141186, 14020.088694234868, 14021.088629239104, 13015.674608134777, 13196.736065278712, 13226.140300880435, 13230.338483075855, 13234.53679121231, 674.8009337245525, 677.7085853083172, 677.7593954146256, 805.7542449552884, 820.8235229425673, 678.372505432473, 806.4516129032256, 815.4903185509057, 817.9713710020151, 821.4742564758529, 856.4732689396039, 864.2178828160525, 864.7059999600135, 864.8140649760301, 865.4417900454204, 854.1927878155146, 854.2695994924344, 855.5123579559654, 855.6662901468401, 862.1249431826701, 519.4078750224746, 523.9659422137549, 609.6464050850497, 614.827848202504, 617.9938200618026, 13051.955843532494, 13152.40814163365, 13161.670958226025, 13196.86803131966, 13198.076134670577, 11676.007539359165, 11787.351695656735, 11979.221350612183, 12163.148579599432, 12392.442340094627, 9937.453440060794, 10178.236632252536, 10319.226058045602, 10389.168866490738, 10494.212934029978, 3545.0960005198767, 3556.875509357186, 3563.1092226943265, 3620.149264922741, 3665.083729067733, 46201.768991155164, 46225.0, 46364.76817615924, 46502.76748616269, 46761.06477870423, 10052.69841904744, 10206.795864082826, 10247.436390998417, 10259.897401025893, 10297.845532317022, 18084.9095754523, 18254.178561964476, 18290.17694203764, 18307.35924242672, 18318.267269309345, 7467.0, 7472.738454154079, 7588.241175882367, 7680.0, 7773.727919522903, 4208.137331846964, 4240.257954857888, 4261.765602891809, 4278.026995036673, 4308.482982042175, 3042.741366983831, 3047.7714171437233, 3052.0538633023834, 3052.3590046090126, 3057.4649436348996, 528.6986417741928, 532.1299675031352, 543.5868739757813, 546.9343678758574, 551.3962211378534, 601.8465291350765, 627.1345543150424, 646.1890327638877, 662.7150325360142, 663.5620490476263, 8221.0, 8430.11483794205, 8763.605637746317, 8783.121687831166, 9074.954625226832, 443.7825465521871, 490.69331667707684, 496.39687779348264, 511.330157493677, 644.4618743349356, 3737.3192747024373, 3802.7147963902817, 3813.199228162117, 3871.341871881787, 4052.1490486997473, 52641.0, 52726.73636631869, 52829.735851320496, 53247.0, 54223.0, 48623.5137648619, 49105.263421048716, 49235.0, 50095.0, 50446.243306350436, 45707.31439028417, 46049.0, 46305.07389852184, 46360.53639463562, 46560.767196163804, 8528.403011789364, 8533.701320453754, 8553.230209281195, 8564.143585641636, 8762.693305734269, 34843.30313393768, 35856.820715896254, 36011.09972250715, 36111.0, 36126.27747444984, 43594.78202608967, 44873.775631121636, 45084.0, 45499.54500454953, 45726.77136614296, 9678.531629629237, 9866.358686685342, 10014.39913605186, 10308.381497109898, 10523.526441310312, 11287.209895307578, 11462.484188211383, 11501.597444089417, 11653.30080195191, 11669.299842009506, 10509.894901050891, 10761.730956726144, 10769.62306319275, 10835.512401941774, 10866.249356206023, 10732.678019659423, 10960.56157753681, 10967.945160274148, 11360.54557817711, 11382.54469821198, 10725.356478611307, 10854.34873907568, 11013.779724405627, 11466.541338346373, 11502.53989840397, 9108.954455227682, 9118.95440522793, 9304.348695591243, 9476.336656433983, 9481.905180948102, 8606.827863442571, 9142.26861851037, 9328.580213890527, 9330.673426430043, 9352.579133938852], "unit": "ms", "name": "yui.html", "value": 6136.60291342765}], "name": "dromaeo_css", "value": 6924.402193489158}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [109.0, 111.0, 105.0, 110.0, 111.0, 110.0, 100.0, 110.0, 108.0, 109.0], "unit": "ms", "name": "ai-astar", "value": 108.3}, {"lowerIsBetter": true, "replicates": [145.0, 123.0, 148.0, 173.0, 125.0, 147.0, 147.0, 124.0, 163.0, 123.0], "unit": "ms", "name": "audio-beat-detection", "value": 141.8}, {"lowerIsBetter": true, "replicates": [161.0, 161.0, 160.0, 162.0, 161.0, 161.0, 161.0, 162.0, 161.0, 163.0], "unit": "ms", "name": "audio-dft", "value": 161.3}, {"lowerIsBetter": true, "replicates": [72.0, 73.0, 78.0, 93.0, 70.0, 70.0, 71.0, 112.0, 89.0, 73.0], "unit": "ms", "name": "audio-fft", "value": 80.1}, {"lowerIsBetter": true, "replicates": [93.0, 93.0, 137.0, 93.0, 92.0, 93.0, 133.0, 93.0, 92.0, 134.0], "unit": "ms", "name": "audio-oscillator", "value": 105.3}, {"lowerIsBetter": true, "replicates": [110.0, 109.0, 109.0, 109.0, 109.0, 109.0, 109.0, 109.0, 110.0, 109.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 109.2}, {"lowerIsBetter": true, "replicates": [146.0, 146.0, 146.0, 146.0, 146.0, 146.0, 146.0, 151.0, 145.0, 145.0], "unit": "ms", "name": "imaging-darkroom", "value": 146.3}, {"lowerIsBetter": true, "replicates": [95.0, 96.0, 96.0, 95.0, 96.0, 97.0, 96.0, 95.0, 97.0, 95.0], "unit": "ms", "name": "imaging-desaturate", "value": 95.8}, {"lowerIsBetter": true, "replicates": [59.0, 63.0, 60.0, 59.0, 60.0, 59.0, 59.0, 59.0, 60.0, 58.0], "unit": "ms", "name": "json-parse-financial", "value": 59.6}, {"lowerIsBetter": true, "replicates": [69.0, 69.0, 69.0, 69.0, 69.0, 69.0, 69.0, 69.0, 72.0, 69.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 69.3}, {"lowerIsBetter": true, "replicates": [88.0, 85.0, 86.0, 85.0, 86.0, 85.0, 85.0, 84.0, 85.0, 84.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 85.3}, {"lowerIsBetter": true, "replicates": [127.0, 123.0, 126.0, 123.0, 114.0, 116.0, 124.0, 132.0, 131.0, 116.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 123.2}, {"lowerIsBetter": true, "replicates": [139.0, 140.0, 150.0, 149.0, 148.0, 140.0, 152.0, 156.0, 154.0, 139.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 146.7}, {"lowerIsBetter": true, "replicates": [65.0, 67.0, 67.0, 66.0, 65.0, 65.0, 67.0, 66.0, 65.0, 65.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 65.8}], "name": "kraken", "value": 1498.0}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [189.3580761219466], "unit": "score", "name": "Richards", "value": 186.42986199999993}, {"lowerIsBetter": false, "replicates": [196.50225977598743], "unit": "score", "name": "DeltaBlue", "value": 336.4745019999999}, {"lowerIsBetter": false, "replicates": [284.7380410022779], "unit": "score", "name": "Encrypt", "value": 934.8276720000003}, {"lowerIsBetter": false, "replicates": [5015.0], "unit": "score", "name": "Decrypt", "value": 53.07696909272185}, {"lowerIsBetter": false, "replicates": [2016.1290322580646], "unit": "score", "name": "RayTrace", "value": 367.03454399999987}, {"lowerIsBetter": false, "replicates": [789.2659826361484], "unit": "score", "name": "Earley", "value": 844.4086210000003}, {"lowerIsBetter": false, "replicates": [11823.529411764706], "unit": "score", "name": "Boyer", "value": 56.36751741293535}, {"lowerIsBetter": false, "replicates": [25425.0], "unit": "score", "name": "RegExp", "value": 35.83028515240902}, {"lowerIsBetter": false, "replicates": [642.2607578676943], "unit": "score", "name": "Splay", "value": 126.88148699999995}, {"lowerIsBetter": false, "replicates": [4835.748792270531], "unit": "score", "name": "NavierStokes", "value": 306.881118881119}], "name": "v8_7", "value": 19480.80355200766}]} 16:02:55 INFO - RETURN: dromaeo_css: 6924.40 16:02:55 INFO - RETURN: kraken: 1498.00 16:02:55 INFO - RETURN: v8_7: 19480.80 16:02:55 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,64,35]]", "result": "19480.80"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,35]]", "result": "1498.00"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,35]]", "result": "6924.40"}}} 16:02:55 INFO - Return code: 0 16:02:55 INFO - # TBPL SUCCESS # 16:02:55 INFO - Running post-action listener: _resource_record_post_action 16:02:55 INFO - Running post-run listener: _resource_record_post_run 16:02:56 INFO - Total resource usage - Wall time: 1229s; CPU: 13.0%; Read bytes: 4096; Write bytes: 507789312; Read time: 8; Write time: 692132 16:02:56 INFO - install - Wall time: 15s; CPU: 15.0%; Read bytes: 0; Write bytes: 221691904; Read time: 0; Write time: 401304 16:02:56 INFO - run-tests - Wall time: 1215s; CPU: 13.0%; Read bytes: 4096; Write bytes: 286097408; Read time: 8; Write time: 290828 16:02:56 INFO - Running post-run listener: _upload_blobber_files 16:02:56 INFO - Blob upload gear active. 16:02:56 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 16:02:56 INFO - Copying logs to upload dir... 16:02:56 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1277.324979 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 17 secs) (at 2015-11-24 16:02:56.155026) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-24 16:02:56.158571) ========= 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=a194aa7faa1be204aaca7d660000020b-1448405851.977553-1733921095 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/sDvUxvG9T1m4MMYOh9Qddg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.010039 build_url: 'https://queue.taskcluster.net/v1/task/sDvUxvG9T1m4MMYOh9Qddg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2' ========= master_lag: 0.04 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-24 16:02:56.212585) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-24 16:02:56.212968) ========= 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=a194aa7faa1be204aaca7d660000020b-1448405851.977553-1733921095 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004490 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-24 16:02:56.263298) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-24 16:02:56.263660) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-24 16:02:56.264013) ========= ========= Total master_lag: 0.28 =========