builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-048 starttime: 1448304564.0 results: success (0) buildid: 20151123083122 builduid: 166a724ce7554a29a834d04db32ec956 revision: bfd81e42d1ddc7071c7fab2598f3099aab30ca92 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-11-23 10:49:24.000962) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-11-23 10:49:24.001471) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-23 10:49:24.001799) ========= 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=fdc9337702648c539b2c5dbe000001aa-1448303012.774549-125941606 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006683 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.01 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-23 10:49:24.022565) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-23 10:49:24.022859) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-23 10:49:24.048890) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 10:49:24.049208) ========= 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=fdc9337702648c539b2c5dbe000001aa-1448303012.774549-125941606 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020782 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 10:49:24.096260) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-23 10:49:24.096574) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-23 10:49:24.096933) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 10:49:24.097204) ========= 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=fdc9337702648c539b2c5dbe000001aa-1448303012.774549-125941606 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-11-23 10:49:24-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.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% 11.6M=0.001s 2015-11-23 10:49:24 (11.6 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.148500 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 10:49:24.257651) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 10:49:24.257959) ========= 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=fdc9337702648c539b2c5dbe000001aa-1448303012.774549-125941606 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.040880 ========= master_lag: 0.01 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 10:49:24.310334) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 10:49:24.310885) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev bfd81e42d1ddc7071c7fab2598f3099aab30ca92 --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 bfd81e42d1ddc7071c7fab2598f3099aab30ca92 --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=fdc9337702648c539b2c5dbe000001aa-1448303012.774549-125941606 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-11-23 10:49:24,919 truncating revision to first 12 chars 2015-11-23 10:49:24,919 Setting DEBUG logging. 2015-11-23 10:49:24,919 attempt 1/10 2015-11-23 10:49:24,919 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/bfd81e42d1dd?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-11-23 10:49:25,154 unpacking tar archive at: fx-team-bfd81e42d1dd/testing/mozharness/ program finished with exit code 0 elapsedTime=0.515396 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 10:49:24.840544) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-23 10:49:24.840841) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-23 10:49:24.851359) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-23 10:49:24.851693) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-23 10:49:24.852135) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 55 secs) (at 2015-11-23 10:49:24.852434) ========= /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=fdc9337702648c539b2c5dbe000001aa-1448303012.774549-125941606 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 10:49:25 INFO - MultiFileLogger online at 20151123 10:49:25 in /builds/slave/test-pgo 10:49:25 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 10:49:25 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 10:49:25 INFO - {'append_to_log': False, 10:49:25 INFO - 'base_work_dir': '/builds/slave/test-pgo', 10:49:25 INFO - 'blob_upload_branch': 'Fx-Team', 10:49:25 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 10:49:25 INFO - 'branch': 'Fx-Team', 10:49:25 INFO - 'buildbot_json_path': 'buildprops.json', 10:49:25 INFO - 'config_files': ('talos/linux_config.py',), 10:49:25 INFO - 'default_actions': ('clobber', 10:49:25 INFO - 'read-buildbot-config', 10:49:25 INFO - 'download-and-extract', 10:49:25 INFO - 'populate-webroot', 10:49:25 INFO - 'create-virtualenv', 10:49:25 INFO - 'install', 10:49:25 INFO - 'run-tests'), 10:49:25 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 10:49:25 INFO - 'download_minidump_stackwalk': True, 10:49:25 INFO - 'download_symbols': 'ondemand', 10:49:25 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 10:49:25 INFO - 'tooltool.py': '/tools/tooltool.py', 10:49:25 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 10:49:25 INFO - '/tools/misc-python/virtualenv.py')}, 10:49:25 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 10:49:25 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 10:49:25 INFO - 'installer_path': 'installer.exe', 10:49:25 INFO - 'log_level': 'info', 10:49:25 INFO - 'log_name': 'talos', 10:49:25 INFO - 'log_to_console': True, 10:49:25 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 10:49:25 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 10:49:25 INFO - 'opt_config_files': (), 10:49:25 INFO - 'pip_index': False, 10:49:25 INFO - 'sps_profile': False, 10:49:25 INFO - 'sps_profile_interval': 0, 10:49:25 INFO - 'suite': 'dromaeojs', 10:49:25 INFO - 'system_bits': '64', 10:49:25 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 10:49:25 INFO - 'title': 'talos-linux64-ix-048', 10:49:25 INFO - 'tooltool_cache': '/builds/tooltool_cache', 10:49:25 INFO - 'use_talos_json': True, 10:49:25 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 10:49:25 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 10:49:25 INFO - 'work_dir': 'build'} 10:49:25 INFO - ##### 10:49:25 INFO - ##### Running clobber step. 10:49:25 INFO - ##### 10:49:25 INFO - Running pre-action listener: _resource_record_pre_action 10:49:25 INFO - Running main action method: clobber 10:49:25 INFO - rmtree: /builds/slave/test-pgo/build 10:49:25 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 10:49:26 INFO - Running post-action listener: _resource_record_post_action 10:49:26 INFO - ##### 10:49:26 INFO - ##### Running read-buildbot-config step. 10:49:26 INFO - ##### 10:49:26 INFO - Running pre-action listener: _resource_record_pre_action 10:49:26 INFO - Running main action method: read_buildbot_config 10:49:26 INFO - Using buildbot properties: 10:49:26 INFO - { 10:49:26 INFO - "properties": { 10:49:26 INFO - "buildnumber": 508, 10:49:26 INFO - "product": "firefox", 10:49:26 INFO - "script_repo_revision": "production", 10:49:26 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 10:49:26 INFO - "repository": "", 10:49:26 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 10:49:26 INFO - "buildid": "20151123083122", 10:49:26 INFO - "slavename": "talos-linux64-ix-048", 10:49:26 INFO - "pgo_build": "True", 10:49:26 INFO - "basedir": "/builds/slave/test-pgo", 10:49:26 INFO - "project": "", 10:49:26 INFO - "platform": "ubuntu64_hw", 10:49:26 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 10:49:26 INFO - "slavebuilddir": "test", 10:49:26 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 10:49:26 INFO - "branch": "fx-team", 10:49:26 INFO - "repo_path": "integration/fx-team", 10:49:26 INFO - "stage_platform": "linux64-pgo", 10:49:26 INFO - "builduid": "166a724ce7554a29a834d04db32ec956", 10:49:26 INFO - "revision": "bfd81e42d1ddc7071c7fab2598f3099aab30ca92" 10:49:26 INFO - }, 10:49:26 INFO - "sourcestamp": { 10:49:26 INFO - "repository": "", 10:49:26 INFO - "hasPatch": false, 10:49:26 INFO - "project": "", 10:49:26 INFO - "branch": "fx-team-linux64-pgo-talos", 10:49:26 INFO - "changes": [ 10:49:26 INFO - { 10:49:26 INFO - "category": null, 10:49:26 INFO - "files": [ 10:49:26 INFO - { 10:49:26 INFO - "url": null, 10:49:26 INFO - "name": "https://queue.taskcluster.net/v1/task/022i7NZkTzWU93J-RU684Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2" 10:49:26 INFO - } 10:49:26 INFO - ], 10:49:26 INFO - "repository": "", 10:49:26 INFO - "rev": "bfd81e42d1ddc7071c7fab2598f3099aab30ca92", 10:49:26 INFO - "who": "sendchange", 10:49:26 INFO - "when": 1448304482, 10:49:26 INFO - "number": 6696209, 10:49:26 INFO - "comments": "", 10:49:26 INFO - "project": "", 10:49:26 INFO - "at": "Mon 23 Nov 2015 10:48:02", 10:49:26 INFO - "branch": "fx-team-linux64-pgo-talos", 10:49:26 INFO - "revlink": "", 10:49:26 INFO - "properties": [ 10:49:26 INFO - [ 10:49:26 INFO - "buildid", 10:49:26 INFO - "20151123083122", 10:49:26 INFO - "Change" 10:49:26 INFO - ], 10:49:26 INFO - [ 10:49:26 INFO - "builduid", 10:49:26 INFO - "166a724ce7554a29a834d04db32ec956", 10:49:26 INFO - "Change" 10:49:26 INFO - ], 10:49:26 INFO - [ 10:49:26 INFO - "pgo_build", 10:49:26 INFO - "True", 10:49:26 INFO - "Change" 10:49:26 INFO - ] 10:49:26 INFO - ], 10:49:26 INFO - "revision": "bfd81e42d1ddc7071c7fab2598f3099aab30ca92" 10:49:26 INFO - } 10:49:26 INFO - ], 10:49:26 INFO - "revision": "bfd81e42d1ddc7071c7fab2598f3099aab30ca92" 10:49:26 INFO - } 10:49:26 INFO - } 10:49:26 INFO - Found installer url https://queue.taskcluster.net/v1/task/022i7NZkTzWU93J-RU684Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2. 10:49:26 INFO - Running post-action listener: _resource_record_post_action 10:49:26 INFO - ##### 10:49:26 INFO - ##### Running download-and-extract step. 10:49:26 INFO - ##### 10:49:26 INFO - Running pre-action listener: _resource_record_pre_action 10:49:26 INFO - Running main action method: download_and_extract 10:49:26 INFO - mkdir: /builds/slave/test-pgo/build/tests 10:49:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:49:26 INFO - https://queue.taskcluster.net/v1/task/022i7NZkTzWU93J-RU684Q/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 10:49:26 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/022i7NZkTzWU93J-RU684Q/artifacts/public/build/test_packages.json 10:49:26 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/022i7NZkTzWU93J-RU684Q/artifacts/public/build/test_packages.json 10:49:26 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/022i7NZkTzWU93J-RU684Q/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 10:49:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/022i7NZkTzWU93J-RU684Q/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 10:49:27 INFO - Downloaded 1302 bytes. 10:49:27 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 10:49:27 INFO - Using the following test package requirements: 10:49:27 INFO - {u'common': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 10:49:27 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 10:49:27 INFO - u'firefox-45.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 10:49:27 INFO - u'jittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 10:49:27 INFO - u'jsshell-linux-x86_64.zip'], 10:49:27 INFO - u'mochitest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 10:49:27 INFO - u'firefox-45.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 10:49:27 INFO - u'mozbase': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 10:49:27 INFO - u'reftest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 10:49:27 INFO - u'firefox-45.0a1.en-US.linux-x86_64.reftest.tests.zip'], 10:49:27 INFO - u'talos': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 10:49:27 INFO - u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'], 10:49:27 INFO - u'web-platform': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 10:49:27 INFO - u'firefox-45.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 10:49:27 INFO - u'webapprt': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 10:49:27 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 10:49:27 INFO - u'firefox-45.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 10:49:27 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 10:49:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:49:27 INFO - https://queue.taskcluster.net/v1/task/022i7NZkTzWU93J-RU684Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 10:49:27 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/022i7NZkTzWU93J-RU684Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 10:49:27 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/022i7NZkTzWU93J-RU684Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 10:49:27 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/022i7NZkTzWU93J-RU684Q/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 10:49:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/022i7NZkTzWU93J-RU684Q/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 10:49:28 INFO - Downloaded 22525651 bytes. 10:49:28 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test-pgo/build/tests 10:49:28 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 10:49:28 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 10:49:29 INFO - Return code: 0 10:49:29 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 10:49:29 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')]} 10:49:29 INFO - https://queue.taskcluster.net/v1/task/022i7NZkTzWU93J-RU684Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 10:49:29 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/022i7NZkTzWU93J-RU684Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 10:49:29 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/022i7NZkTzWU93J-RU684Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 10:49:29 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/022i7NZkTzWU93J-RU684Q/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 10:49:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/022i7NZkTzWU93J-RU684Q/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 10:49:30 INFO - Downloaded 22525651 bytes. 10:49:30 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 10:49:30 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 10:49:30 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 10:49:32 INFO - Return code: 0 10:49:32 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')]} 10:49:32 INFO - https://queue.taskcluster.net/v1/task/022i7NZkTzWU93J-RU684Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 10:49:32 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/022i7NZkTzWU93J-RU684Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 10:49:32 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/022i7NZkTzWU93J-RU684Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 10:49:32 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/022i7NZkTzWU93J-RU684Q/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 10:49:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/022i7NZkTzWU93J-RU684Q/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 10:49:33 INFO - Downloaded 11130997 bytes. 10:49:33 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 10:49:33 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 10:49:33 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 10:49:33 INFO - Return code: 0 10:49:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:49:33 INFO - https://queue.taskcluster.net/v1/task/022i7NZkTzWU93J-RU684Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 10:49:33 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/022i7NZkTzWU93J-RU684Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 10:49:33 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/022i7NZkTzWU93J-RU684Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 10:49:33 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/022i7NZkTzWU93J-RU684Q/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 10:49:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/022i7NZkTzWU93J-RU684Q/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 10:49:34 INFO - Downloaded 57562603 bytes. 10:49:34 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/022i7NZkTzWU93J-RU684Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 10:49:34 INFO - mkdir: /builds/slave/test-pgo/properties 10:49:34 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 10:49:34 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 10:49:34 INFO - Contents: 10:49:34 INFO - build_url:https://queue.taskcluster.net/v1/task/022i7NZkTzWU93J-RU684Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 10:49:34 INFO - Running post-action listener: _resource_record_post_action 10:49:34 INFO - Running post-action listener: set_extra_try_arguments 10:49:34 INFO - ##### 10:49:34 INFO - ##### Running populate-webroot step. 10:49:34 INFO - ##### 10:49:34 INFO - Running pre-action listener: _resource_record_pre_action 10:49:34 INFO - Running main action method: populate_webroot 10:49:34 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 10:49:34 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 10:49:34 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 10:49:34 INFO - '../fennec_ids.txt'], 10:49:34 INFO - 'tests': ['tcheck2']}, 10:49:34 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 10:49:34 INFO - '--tppagecycles', 10:49:34 INFO - '7'], 10:49:34 INFO - 'tests': ['tsvgm']}}, 10:49:34 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 10:49:34 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 10:49:34 INFO - 'tests': ['tresize', 'tcanvasmark']}, 10:49:34 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 10:49:34 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 10:49:34 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 10:49:34 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:49:34 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:49:34 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:49:34 INFO - 'talos_options': ['--e10s'], 10:49:34 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:49:34 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:49:34 INFO - 'tests': ['damp', 'tps']}, 10:49:34 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:49:34 INFO - 'talos_options': ['--e10s'], 10:49:34 INFO - 'tests': ['damp', 'tps']}, 10:49:34 INFO - 'g3': {'tests': ['dromaeo_dom']}, 10:49:34 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 10:49:34 INFO - 'other': {'tests': ['a11yr', 10:49:34 INFO - 'ts_paint', 10:49:34 INFO - 'tpaint', 10:49:34 INFO - 'sessionrestore', 10:49:34 INFO - 'sessionrestore_no_auto_restore']}, 10:49:34 INFO - 'other-e10s': {'talos_options': ['--e10s'], 10:49:34 INFO - 'tests': ['a11yr', 10:49:34 INFO - 'ts_paint', 10:49:34 INFO - 'tpaint', 10:49:34 INFO - 'sessionrestore', 10:49:34 INFO - 'sessionrestore_no_auto_restore']}, 10:49:34 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 10:49:34 INFO - 'tests': ['a11yr', 10:49:34 INFO - 'ts_paint', 10:49:34 INFO - 'tpaint', 10:49:34 INFO - 'sessionrestore', 10:49:34 INFO - 'sessionrestore_no_auto_restore']}, 10:49:34 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 10:49:34 INFO - 'tests': ['a11yr', 10:49:34 INFO - 'ts_paint', 10:49:34 INFO - 'tpaint', 10:49:34 INFO - 'sessionrestore', 10:49:34 INFO - 'sessionrestore_no_auto_restore']}, 10:49:34 INFO - 'other_l64': {'tests': ['a11yr', 10:49:34 INFO - 'ts_paint', 10:49:34 INFO - 'tpaint', 10:49:34 INFO - 'sessionrestore', 10:49:34 INFO - 'sessionrestore_no_auto_restore']}, 10:49:34 INFO - 'other_nol64': {'tests': ['a11yr', 10:49:34 INFO - 'ts_paint', 10:49:34 INFO - 'tpaint', 10:49:34 INFO - 'sessionrestore', 10:49:34 INFO - 'sessionrestore_no_auto_restore']}, 10:49:34 INFO - 'svgr': {'tests': ['tsvgx', 10:49:34 INFO - 'tsvgr_opacity', 10:49:34 INFO - 'tart', 10:49:34 INFO - 'tscrollx', 10:49:34 INFO - 'cart']}, 10:49:34 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 10:49:34 INFO - 'tests': ['tsvgx', 10:49:34 INFO - 'tsvgr_opacity', 10:49:34 INFO - 'tart', 10:49:34 INFO - 'tscrollx', 10:49:34 INFO - 'cart']}, 10:49:34 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:49:34 INFO - 'tests': ['tp5o']}, 10:49:34 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:49:34 INFO - 'talos_options': ['--e10s'], 10:49:34 INFO - 'tests': ['tp5o']}, 10:49:34 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:49:34 INFO - 'talos_options': ['--xperf_path', 10:49:34 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:49:34 INFO - 'tests': ['tp5n']}, 10:49:34 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:49:34 INFO - 'talos_options': ['--e10s', 10:49:34 INFO - '--xperf_path', 10:49:34 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:49:34 INFO - 'tests': ['tp5n']}}, 10:49:34 INFO - 'talos.zip': {'path': '', 10:49:34 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 10:49:34 INFO - Running post-action listener: _resource_record_post_action 10:49:34 INFO - ##### 10:49:34 INFO - ##### Running create-virtualenv step. 10:49:34 INFO - ##### 10:49:34 INFO - Running pre-action listener: _resource_record_pre_action 10:49:34 INFO - Running main action method: create_virtualenv 10:49:34 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 10:49:34 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 10:49:34 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 10:49:34 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 10:49:34 INFO - Using real prefix '/usr' 10:49:34 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 10:49:35 INFO - Installing distribute.............................................................................................................................................................................................done. 10:49:37 INFO - Installing pip.................done. 10:49:37 INFO - Return code: 0 10:49:37 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 10:49:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:49:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:49:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:49:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:49:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:49:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:49:37 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 0x7f7f0d5ecc70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15cf6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16817c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16c5d70>, '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 0x16c6b20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16c6fb0>, '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': 'fdc9337702648c539b2c5dbe000001aa-1448303012.774549-125941606', '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 10:49:37 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 10:49:37 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 10:49:37 INFO - Using env: {'DISPLAY': ':0', 10:49:37 INFO - 'HOME': '/home/cltbld', 10:49:37 INFO - 'LANG': 'en_US.UTF-8', 10:49:37 INFO - 'LANGUAGE': 'en_US:en', 10:49:37 INFO - 'LOGNAME': 'cltbld', 10:49:37 INFO - 'MAIL': '/var/mail/cltbld', 10:49:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:49:37 INFO - 'MOZ_NO_REMOTE': '1', 10:49:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:49:37 INFO - 'NO_EM_RESTART': '1', 10:49:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:49:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:49:37 INFO - 'PWD': '/builds/slave/test-pgo', 10:49:37 INFO - 'SHELL': '/bin/bash', 10:49:37 INFO - 'SHLVL': '1', 10:49:37 INFO - 'TERM': 'linux', 10:49:37 INFO - 'TMOUT': '86400', 10:49:37 INFO - 'USER': 'cltbld', 10:49:37 INFO - 'XDG_SESSION_COOKIE': 'fdc9337702648c539b2c5dbe000001aa-1448303012.774549-125941606', 10:49:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:49:37 INFO - '_': '/tools/buildbot/bin/python'} 10:49:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:49:37 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 10:49:37 INFO - Cleaning up... 10:49:37 INFO - Return code: 0 10:49:37 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 10:49:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:49:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:49:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:49:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:49:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:49:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:49:37 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 0x7f7f0d5ecc70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15cf6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16817c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16c5d70>, '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 0x16c6b20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16c6fb0>, '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': 'fdc9337702648c539b2c5dbe000001aa-1448303012.774549-125941606', '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 10:49:37 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 10:49:37 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 10:49:37 INFO - Using env: {'DISPLAY': ':0', 10:49:37 INFO - 'HOME': '/home/cltbld', 10:49:37 INFO - 'LANG': 'en_US.UTF-8', 10:49:37 INFO - 'LANGUAGE': 'en_US:en', 10:49:37 INFO - 'LOGNAME': 'cltbld', 10:49:37 INFO - 'MAIL': '/var/mail/cltbld', 10:49:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:49:37 INFO - 'MOZ_NO_REMOTE': '1', 10:49:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:49:37 INFO - 'NO_EM_RESTART': '1', 10:49:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:49:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:49:37 INFO - 'PWD': '/builds/slave/test-pgo', 10:49:37 INFO - 'SHELL': '/bin/bash', 10:49:37 INFO - 'SHLVL': '1', 10:49:37 INFO - 'TERM': 'linux', 10:49:37 INFO - 'TMOUT': '86400', 10:49:37 INFO - 'USER': 'cltbld', 10:49:37 INFO - 'XDG_SESSION_COOKIE': 'fdc9337702648c539b2c5dbe000001aa-1448303012.774549-125941606', 10:49:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:49:37 INFO - '_': '/tools/buildbot/bin/python'} 10:49:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:49:37 INFO - Downloading/unpacking psutil>=0.7.1 10:49:37 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 10:49:37 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 10:49:37 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 10:49:37 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 10:49:37 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 10:49:37 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 10:49:39 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 10:49:39 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 10:49:39 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 10:49:39 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:49:39 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:49:39 INFO - Installing collected packages: psutil 10:49:39 INFO - Running setup.py install for psutil 10:49:39 INFO - building 'psutil._psutil_linux' extension 10:49:39 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 10:49:39 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 10:49:39 INFO - building 'psutil._psutil_posix' extension 10:49:39 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 10:49:39 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 10:49:40 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:49:40 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:49:40 INFO - Successfully installed psutil 10:49:40 INFO - Cleaning up... 10:49:40 INFO - Return code: 0 10:49:40 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 10:49:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:49:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:49:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:49:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:49:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:49:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:49:40 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 0x7f7f0d5ecc70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15cf6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16817c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16c5d70>, '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 0x16c6b20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16c6fb0>, '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': 'fdc9337702648c539b2c5dbe000001aa-1448303012.774549-125941606', '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 10:49:40 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 10:49:40 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 10:49:40 INFO - Using env: {'DISPLAY': ':0', 10:49:40 INFO - 'HOME': '/home/cltbld', 10:49:40 INFO - 'LANG': 'en_US.UTF-8', 10:49:40 INFO - 'LANGUAGE': 'en_US:en', 10:49:40 INFO - 'LOGNAME': 'cltbld', 10:49:40 INFO - 'MAIL': '/var/mail/cltbld', 10:49:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:49:40 INFO - 'MOZ_NO_REMOTE': '1', 10:49:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:49:40 INFO - 'NO_EM_RESTART': '1', 10:49:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:49:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:49:40 INFO - 'PWD': '/builds/slave/test-pgo', 10:49:40 INFO - 'SHELL': '/bin/bash', 10:49:40 INFO - 'SHLVL': '1', 10:49:40 INFO - 'TERM': 'linux', 10:49:40 INFO - 'TMOUT': '86400', 10:49:40 INFO - 'USER': 'cltbld', 10:49:40 INFO - 'XDG_SESSION_COOKIE': 'fdc9337702648c539b2c5dbe000001aa-1448303012.774549-125941606', 10:49:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:49:40 INFO - '_': '/tools/buildbot/bin/python'} 10:49:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:49:40 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 10:49:40 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 10:49:40 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 10:49:40 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 10:49:40 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 10:49:40 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 10:49:40 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 10:49:41 INFO - Downloading mozsystemmonitor-0.0.tar.gz 10:49:41 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 10:49:41 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 10:49:42 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 10:49:42 INFO - Installing collected packages: mozsystemmonitor 10:49:42 INFO - Running setup.py install for mozsystemmonitor 10:49:42 INFO - Successfully installed mozsystemmonitor 10:49:42 INFO - Cleaning up... 10:49:42 INFO - Return code: 0 10:49:42 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 10:49:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:49:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:49:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:49:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:49:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:49:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:49:42 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 0x7f7f0d5ecc70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15cf6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16817c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16c5d70>, '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 0x16c6b20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16c6fb0>, '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': 'fdc9337702648c539b2c5dbe000001aa-1448303012.774549-125941606', '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 10:49:42 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 10:49:42 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 10:49:42 INFO - Using env: {'DISPLAY': ':0', 10:49:42 INFO - 'HOME': '/home/cltbld', 10:49:42 INFO - 'LANG': 'en_US.UTF-8', 10:49:42 INFO - 'LANGUAGE': 'en_US:en', 10:49:42 INFO - 'LOGNAME': 'cltbld', 10:49:42 INFO - 'MAIL': '/var/mail/cltbld', 10:49:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:49:42 INFO - 'MOZ_NO_REMOTE': '1', 10:49:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:49:42 INFO - 'NO_EM_RESTART': '1', 10:49:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:49:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:49:42 INFO - 'PWD': '/builds/slave/test-pgo', 10:49:42 INFO - 'SHELL': '/bin/bash', 10:49:42 INFO - 'SHLVL': '1', 10:49:42 INFO - 'TERM': 'linux', 10:49:42 INFO - 'TMOUT': '86400', 10:49:42 INFO - 'USER': 'cltbld', 10:49:42 INFO - 'XDG_SESSION_COOKIE': 'fdc9337702648c539b2c5dbe000001aa-1448303012.774549-125941606', 10:49:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:49:42 INFO - '_': '/tools/buildbot/bin/python'} 10:49:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:49:42 INFO - Downloading/unpacking blobuploader==1.2.4 10:49:42 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 10:49:42 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 10:49:42 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 10:49:42 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 10:49:42 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 10:49:42 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 10:49:44 INFO - Downloading blobuploader-1.2.4.tar.gz 10:49:44 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 10:49:44 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 10:49:44 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 10:49:44 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 10:49:44 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 10:49:44 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 10:49:44 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 10:49:44 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 10:49:44 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 10:49:44 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 10:49:44 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 10:49:44 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 10:49:44 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 10:49:44 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 10:49:44 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 10:49:44 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 10:49:44 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 10:49:44 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 10:49:44 INFO - Downloading docopt-0.6.1.tar.gz 10:49:44 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 10:49:44 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 10:49:44 INFO - Installing collected packages: blobuploader, requests, docopt 10:49:44 INFO - Running setup.py install for blobuploader 10:49:44 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 10:49:44 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 10:49:44 INFO - Running setup.py install for requests 10:49:45 INFO - Running setup.py install for docopt 10:49:45 INFO - Successfully installed blobuploader requests docopt 10:49:45 INFO - Cleaning up... 10:49:45 INFO - Return code: 0 10:49:45 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 10:49:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:49:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:49:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:49:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:49:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:49:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:49:45 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 0x7f7f0d5ecc70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15cf6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16817c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16c5d70>, '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 0x16c6b20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16c6fb0>, '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': 'fdc9337702648c539b2c5dbe000001aa-1448303012.774549-125941606', '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 10:49:45 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 10:49:45 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 10:49:45 INFO - Using env: {'DISPLAY': ':0', 10:49:45 INFO - 'HOME': '/home/cltbld', 10:49:45 INFO - 'LANG': 'en_US.UTF-8', 10:49:45 INFO - 'LANGUAGE': 'en_US:en', 10:49:45 INFO - 'LOGNAME': 'cltbld', 10:49:45 INFO - 'MAIL': '/var/mail/cltbld', 10:49:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:49:45 INFO - 'MOZ_NO_REMOTE': '1', 10:49:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:49:45 INFO - 'NO_EM_RESTART': '1', 10:49:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:49:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:49:45 INFO - 'PWD': '/builds/slave/test-pgo', 10:49:45 INFO - 'SHELL': '/bin/bash', 10:49:45 INFO - 'SHLVL': '1', 10:49:45 INFO - 'TERM': 'linux', 10:49:45 INFO - 'TMOUT': '86400', 10:49:45 INFO - 'USER': 'cltbld', 10:49:45 INFO - 'XDG_SESSION_COOKIE': 'fdc9337702648c539b2c5dbe000001aa-1448303012.774549-125941606', 10:49:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:49:45 INFO - '_': '/tools/buildbot/bin/python'} 10:49:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:49:45 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 10:49:45 INFO - Running setup.py (path:/tmp/pip-yDXfeC-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 10:49:45 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 10:49:45 INFO - Running setup.py (path:/tmp/pip-vbUsaE-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 10:49:45 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 10:49:45 INFO - Running setup.py (path:/tmp/pip-CyvAuT-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 10:49:45 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 10:49:45 INFO - Running setup.py (path:/tmp/pip-4XFDfU-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 10:49:45 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 10:49:45 INFO - Running setup.py (path:/tmp/pip-XEnjmO-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 10:49:45 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 10:49:45 INFO - Running setup.py (path:/tmp/pip-Z0es9i-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 10:49:45 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 10:49:45 INFO - Running setup.py (path:/tmp/pip-7cmtNv-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 10:49:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 10:49:46 INFO - Running setup.py (path:/tmp/pip-YaQ3K5-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 10:49:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 10:49:46 INFO - Running setup.py (path:/tmp/pip-6qwEmp-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 10:49:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 10:49:46 INFO - Running setup.py (path:/tmp/pip-rHByUp-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 10:49:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 10:49:46 INFO - Running setup.py (path:/tmp/pip-XG7DvR-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 10:49:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 10:49:46 INFO - Running setup.py (path:/tmp/pip-im2xdd-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 10:49:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 10:49:46 INFO - Running setup.py (path:/tmp/pip-_hClK6-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 10:49:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 10:49:46 INFO - Running setup.py (path:/tmp/pip-sHBpyl-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 10:49:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 10:49:46 INFO - Running setup.py (path:/tmp/pip-e1WabX-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 10:49:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 10:49:46 INFO - Running setup.py (path:/tmp/pip-lw8LBG-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 10:49:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 10:49:46 INFO - Running setup.py (path:/tmp/pip-S5Pw3z-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 10:49:46 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 10:49:46 INFO - Running setup.py install for manifestparser 10:49:46 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 10:49:46 INFO - Running setup.py install for mozcrash 10:49:46 INFO - Running setup.py install for mozdebug 10:49:47 INFO - Running setup.py install for mozdevice 10:49:47 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 10:49:47 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 10:49:47 INFO - Running setup.py install for mozfile 10:49:47 INFO - Running setup.py install for mozhttpd 10:49:47 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 10:49:47 INFO - Running setup.py install for mozinfo 10:49:47 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 10:49:47 INFO - Running setup.py install for mozInstall 10:49:47 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 10:49:47 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 10:49:47 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 10:49:47 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 10:49:47 INFO - Running setup.py install for mozleak 10:49:47 INFO - Running setup.py install for mozlog 10:49:47 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 10:49:47 INFO - Running setup.py install for moznetwork 10:49:47 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 10:49:47 INFO - Running setup.py install for mozprocess 10:49:47 INFO - Running setup.py install for mozprofile 10:49:48 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 10:49:48 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 10:49:48 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 10:49:48 INFO - Running setup.py install for mozrunner 10:49:48 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 10:49:48 INFO - Running setup.py install for mozscreenshot 10:49:48 INFO - Running setup.py install for moztest 10:49:48 INFO - Running setup.py install for mozversion 10:49:48 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 10:49:48 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 10:49:48 INFO - Cleaning up... 10:49:48 INFO - Return code: 0 10:49:48 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 10:49:48 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')]} 10:49:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:49:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:49:48 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')]} 10:49:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:49:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:49:48 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 0x7f7f0d5ecc70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15cf6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16817c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16c5d70>, '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 0x16c6b20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16c6fb0>, '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': 'fdc9337702648c539b2c5dbe000001aa-1448303012.774549-125941606', '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 10:49:48 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 10:49:48 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 10:49:48 INFO - Using env: {'DISPLAY': ':0', 10:49:48 INFO - 'HOME': '/home/cltbld', 10:49:48 INFO - 'LANG': 'en_US.UTF-8', 10:49:48 INFO - 'LANGUAGE': 'en_US:en', 10:49:48 INFO - 'LOGNAME': 'cltbld', 10:49:48 INFO - 'MAIL': '/var/mail/cltbld', 10:49:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:49:48 INFO - 'MOZ_NO_REMOTE': '1', 10:49:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:49:48 INFO - 'NO_EM_RESTART': '1', 10:49:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:49:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:49:48 INFO - 'PWD': '/builds/slave/test-pgo', 10:49:48 INFO - 'SHELL': '/bin/bash', 10:49:48 INFO - 'SHLVL': '1', 10:49:48 INFO - 'TERM': 'linux', 10:49:48 INFO - 'TMOUT': '86400', 10:49:48 INFO - 'USER': 'cltbld', 10:49:48 INFO - 'XDG_SESSION_COOKIE': 'fdc9337702648c539b2c5dbe000001aa-1448303012.774549-125941606', 10:49:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:49:48 INFO - '_': '/tools/buildbot/bin/python'} 10:49:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:49:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 10:49:48 INFO - Running setup.py (path:/tmp/pip-nN9Yvk-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 10:49:48 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)) 10:49:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 10:49:48 INFO - Running setup.py (path:/tmp/pip-9Iyjvx-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 10:49:48 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)) 10:49:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 10:49:48 INFO - Running setup.py (path:/tmp/pip-cRJ3Sj-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 10:49:48 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)) 10:49:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 10:49:48 INFO - Running setup.py (path:/tmp/pip-V0oKVQ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 10:49:49 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)) 10:49:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 10:49:49 INFO - Running setup.py (path:/tmp/pip-Z9K19O-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 10:49:49 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)) 10:49:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 10:49:49 INFO - Running setup.py (path:/tmp/pip-im2McH-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 10:49:49 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)) 10:49:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 10:49:49 INFO - Running setup.py (path:/tmp/pip-dZ49Nh-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 10:49:49 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)) 10:49:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 10:49:49 INFO - Running setup.py (path:/tmp/pip-5YPcnr-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 10:49:49 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)) 10:49:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 10:49:49 INFO - Running setup.py (path:/tmp/pip-CZQFMj-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 10:49:49 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)) 10:49:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 10:49:49 INFO - Running setup.py (path:/tmp/pip-wCegSU-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 10:49:49 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)) 10:49:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 10:49:49 INFO - Running setup.py (path:/tmp/pip-WPBOQH-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 10:49:49 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)) 10:49:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 10:49:49 INFO - Running setup.py (path:/tmp/pip-vs5swA-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 10:49:49 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)) 10:49:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 10:49:49 INFO - Running setup.py (path:/tmp/pip-hrYjmd-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 10:49:49 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)) 10:49:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 10:49:49 INFO - Running setup.py (path:/tmp/pip-gYD8sq-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 10:49:49 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)) 10:49:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 10:49:49 INFO - Running setup.py (path:/tmp/pip-dobpDa-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 10:49:49 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)) 10:49:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 10:49:49 INFO - Running setup.py (path:/tmp/pip-Bxv1Dr-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 10:49:49 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)) 10:49:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 10:49:49 INFO - Running setup.py (path:/tmp/pip-HPAUlS-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 10:49:49 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)) 10:49:49 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)) 10:49:49 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)) 10:49:49 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)) 10:49:49 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)) 10:49:49 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)) 10:49:49 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 10:49:49 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 10:49:49 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 10:49:49 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 10:49:49 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 10:49:49 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 10:49:49 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 10:49:51 INFO - Downloading blessings-1.5.1.tar.gz 10:49:51 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 10:49:51 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 10:49:51 INFO - Installing collected packages: blessings 10:49:51 INFO - Running setup.py install for blessings 10:49:51 INFO - Successfully installed blessings 10:49:51 INFO - Cleaning up... 10:49:51 INFO - Return code: 0 10:49:51 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 10:49:51 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 10:49:51 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 10:49:52 INFO - Reading from file tmpfile_stdout 10:49:52 INFO - Current package versions: 10:49:52 INFO - argparse == 1.2.1 10:49:52 INFO - blessings == 1.5.1 10:49:52 INFO - blobuploader == 1.2.4 10:49:52 INFO - docopt == 0.6.1 10:49:52 INFO - manifestparser == 1.1 10:49:52 INFO - mozInstall == 1.12 10:49:52 INFO - mozcrash == 0.16 10:49:52 INFO - mozdebug == 0.1 10:49:52 INFO - mozdevice == 0.47 10:49:52 INFO - mozfile == 1.2 10:49:52 INFO - mozhttpd == 0.7 10:49:52 INFO - mozinfo == 0.9 10:49:52 INFO - mozleak == 0.1 10:49:52 INFO - mozlog == 3.1 10:49:52 INFO - moznetwork == 0.27 10:49:52 INFO - mozprocess == 0.22 10:49:52 INFO - mozprofile == 0.27 10:49:52 INFO - mozrunner == 6.11 10:49:52 INFO - mozscreenshot == 0.1 10:49:52 INFO - mozsystemmonitor == 0.0 10:49:52 INFO - moztest == 0.7 10:49:52 INFO - mozversion == 1.4 10:49:52 INFO - psutil == 3.1.1 10:49:52 INFO - requests == 1.2.3 10:49:52 INFO - wsgiref == 0.1.2 10:49:52 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 10:49:52 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')]} 10:49:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:49:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:49:52 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')]} 10:49:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:49:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:49:52 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 0x7f7f0d5ecc70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15cf6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16817c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16c5d70>, '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 0x16c6b20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16c6fb0>, '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': 'fdc9337702648c539b2c5dbe000001aa-1448303012.774549-125941606', '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 10:49:52 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 10:49:52 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 10:49:52 INFO - Using env: {'DISPLAY': ':0', 10:49:52 INFO - 'HOME': '/home/cltbld', 10:49:52 INFO - 'LANG': 'en_US.UTF-8', 10:49:52 INFO - 'LANGUAGE': 'en_US:en', 10:49:52 INFO - 'LOGNAME': 'cltbld', 10:49:52 INFO - 'MAIL': '/var/mail/cltbld', 10:49:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:49:52 INFO - 'MOZ_NO_REMOTE': '1', 10:49:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:49:52 INFO - 'NO_EM_RESTART': '1', 10:49:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:49:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:49:52 INFO - 'PWD': '/builds/slave/test-pgo', 10:49:52 INFO - 'SHELL': '/bin/bash', 10:49:52 INFO - 'SHLVL': '1', 10:49:52 INFO - 'TERM': 'linux', 10:49:52 INFO - 'TMOUT': '86400', 10:49:52 INFO - 'USER': 'cltbld', 10:49:52 INFO - 'XDG_SESSION_COOKIE': 'fdc9337702648c539b2c5dbe000001aa-1448303012.774549-125941606', 10:49:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:49:52 INFO - '_': '/tools/buildbot/bin/python'} 10:49:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:49:52 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)) 10:49:52 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)) 10:49:52 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)) 10:49:52 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)) 10:49:52 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)) 10:49:52 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)) 10:49:52 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)) 10:49:52 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)) 10:49:52 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)) 10:49:52 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)) 10:49:52 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)) 10:49:52 INFO - Cleaning up... 10:49:52 INFO - Return code: 0 10:49:52 INFO - Running post-action listener: _resource_record_post_action 10:49:52 INFO - Running post-action listener: _start_resource_monitoring 10:49:52 INFO - Starting resource monitoring. 10:49:52 INFO - ##### 10:49:52 INFO - ##### Running install step. 10:49:52 INFO - ##### 10:49:52 INFO - Running pre-action listener: _resource_record_pre_action 10:49:52 INFO - Running main action method: install 10:49:52 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 10:49:52 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 10:49:52 INFO - Reading from file tmpfile_stdout 10:49:52 INFO - Detecting whether we're running mozinstall >=1.0... 10:49:52 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 10:49:52 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 10:49:52 INFO - Reading from file tmpfile_stdout 10:49:52 INFO - Output received: 10:49:52 INFO - Usage: mozinstall [options] installer 10:49:52 INFO - Options: 10:49:52 INFO - -h, --help show this help message and exit 10:49:52 INFO - -d DEST, --destination=DEST 10:49:52 INFO - Directory to install application into. [default: 10:49:52 INFO - "/builds/slave/test-pgo"] 10:49:52 INFO - --app=APP Application being installed. [default: firefox] 10:49:52 INFO - mkdir: /builds/slave/test-pgo/build/application 10:49:52 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'] 10:49:52 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 10:50:07 INFO - Reading from file tmpfile_stdout 10:50:07 INFO - Output received: 10:50:07 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 10:50:08 INFO - Running post-action listener: _resource_record_post_action 10:50:08 INFO - ##### 10:50:08 INFO - ##### Running run-tests step. 10:50:08 INFO - ##### 10:50:08 INFO - Running pre-action listener: _resource_record_pre_action 10:50:08 INFO - Running main action method: run_tests 10:50:08 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 10:50:08 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 10:50:08 INFO - Python 2.7.3 10:50:08 INFO - Return code: 0 10:50:08 INFO - grabbing minidump binary from tooltool 10:50:08 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')]} 10:50:08 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 0x16c5d70>, '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 0x16c6b20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16c6fb0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 10:50:08 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 10:50:08 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 10:50:08 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 10:50:08 INFO - Return code: 0 10:50:08 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 10:50:08 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 10:50:08 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 10:50:08 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 10:50:08 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 10:50:08 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/022i7NZkTzWU93J-RU684Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-048', '--webServer', 'localhost'] in /builds/slave/test-pgo/build 10:50:08 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/022i7NZkTzWU93J-RU684Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-048 --webServer localhost 10:50:08 INFO - Using env: {'DISPLAY': ':0', 10:50:08 INFO - 'HOME': '/home/cltbld', 10:50:08 INFO - 'LANG': 'en_US.UTF-8', 10:50:08 INFO - 'LANGUAGE': 'en_US:en', 10:50:08 INFO - 'LOGNAME': 'cltbld', 10:50:08 INFO - 'MAIL': '/var/mail/cltbld', 10:50:08 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 10:50:08 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 10:50:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:50:08 INFO - 'MOZ_NO_REMOTE': '1', 10:50:08 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 10:50:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:50:08 INFO - 'NO_EM_RESTART': '1', 10:50:08 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:50:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:50:08 INFO - 'PWD': '/builds/slave/test-pgo', 10:50:08 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 10:50:08 INFO - 'SHELL': '/bin/bash', 10:50:08 INFO - 'SHLVL': '1', 10:50:08 INFO - 'TERM': 'linux', 10:50:08 INFO - 'TMOUT': '86400', 10:50:08 INFO - 'USER': 'cltbld', 10:50:08 INFO - 'XDG_SESSION_COOKIE': 'fdc9337702648c539b2c5dbe000001aa-1448303012.774549-125941606', 10:50:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:50:08 INFO - '_': '/tools/buildbot/bin/python'} 10:50:08 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/022i7NZkTzWU93J-RU684Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-048', '--webServer', 'localhost'] with output_timeout 3600 10:50:08 INFO - mozversion INFO | application_buildid: 20151123083122 10:50:08 INFO - mozversion INFO | application_changeset: bfd81e42d1ddc7071c7fab2598f3099aab30ca92 10:50:08 INFO - mozversion INFO | application_display_name: Nightly 10:50:08 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 10:50:08 INFO - mozversion INFO | application_name: Firefox 10:50:08 INFO - mozversion INFO | application_remotingname: firefox 10:50:08 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/fx-team 10:50:08 INFO - mozversion INFO | application_vendor: Mozilla 10:50:08 INFO - mozversion INFO | application_version: 45.0a1 10:50:08 INFO - mozversion INFO | platform_buildid: 20151123083122 10:50:08 INFO - mozversion INFO | platform_changeset: bfd81e42d1ddc7071c7fab2598f3099aab30ca92 10:50:08 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/fx-team 10:50:08 INFO - mozversion INFO | platform_version: 45.0a1 10:50:08 INFO - 2015-11-23 10:50:08,436 DEBUG : using testdate: 1448304608 10:50:08 INFO - 2015-11-23 10:50:08,436 DEBUG : actual date: 1448304608 10:50:08 INFO - 2015-11-23 10:50:08,444 INFO : starting webserver on 'localhost:39633' 10:50:08 INFO - 2015-11-23 10:50:08,445 INFO : Starting test suite talos-linux64-ix-048 10:50:08 INFO - 2015-11-23 10:50:08,445 INFO : Starting test dromaeo_css 10:50:08 INFO - 2015-11-23 10:50:08,445 DEBUG : operating with platform_type : linux_ 10:50:08 INFO - 2015-11-23 10:50:08,446 INFO : Initialising browser for dromaeo_css test... 10:50:08 INFO - 2015-11-23 10:50:08,457 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpJq9C_j/profile http://localhost:39633/getInfo.html 10:50:12 INFO - 2015-11-23 10:50:12,176 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 10:50:12 INFO - 2015-11-23 10:50:12,176 DEBUG : BROWSER_OUTPUT: colorDepth:24 10:50:12 INFO - 2015-11-23 10:50:12,176 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 10:50:12 INFO - 2015-11-23 10:50:12,176 DEBUG : BROWSER_OUTPUT: __metrics 10:50:12 INFO - 2015-11-23 10:50:12,333 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 10:50:13 INFO - 2015-11-23 10:50:13,463 INFO : Browser initialized. 10:50:13 INFO - 2015-11-23 10:50:13,464 INFO : Running cycle 1/1 for dromaeo_css test... 10:50:13 INFO - 2015-11-23 10:50:13,464 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpJq9C_j/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 10:50:25 INFO - 2015-11-23 10:50:25,207 DEBUG : BROWSER_OUTPUT: RSS: Main: 139722752 10:50:25 INFO - 2015-11-23 10:50:25,208 DEBUG : BROWSER_OUTPUT: 10:51:16 INFO - 2015-11-23 10:51:16,030 DEBUG : BROWSER_OUTPUT: 1448304676022 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] 10:53:25 INFO - 2015-11-23 10:53:25,537 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39633/tests/dromaeo/cssquery-dojo.html (next: http://localhost:39633/tests/dromaeo/cssquery-ext.html) 10:53:27 INFO - 2015-11-23 10:53:27,076 DEBUG : BROWSER_OUTPUT: RSS: Main: 305610752 10:53:27 INFO - 2015-11-23 10:53:27,076 DEBUG : BROWSER_OUTPUT: 10:56:29 INFO - 2015-11-23 10:56:29,580 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39633/tests/dromaeo/cssquery-ext.html (next: http://localhost:39633/tests/dromaeo/cssquery-jquery.html) 10:56:30 INFO - 2015-11-23 10:56:30,146 DEBUG : BROWSER_OUTPUT: RSS: Main: 227049472 10:56:30 INFO - 2015-11-23 10:56:30,147 DEBUG : BROWSER_OUTPUT: 10:59:32 INFO - 2015-11-23 10:59:32,114 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39633/tests/dromaeo/cssquery-jquery.html (next: http://localhost:39633/tests/dromaeo/cssquery-mootools.html) 10:59:32 INFO - 2015-11-23 10:59:32,675 DEBUG : BROWSER_OUTPUT: RSS: Main: 223608832 10:59:32 INFO - 2015-11-23 10:59:32,676 DEBUG : BROWSER_OUTPUT: 11:02:34 INFO - 2015-11-23 11:02:34,602 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39633/tests/dromaeo/cssquery-mootools.html (next: http://localhost:39633/tests/dromaeo/cssquery-prototype.html) 11:02:35 INFO - 2015-11-23 11:02:35,195 DEBUG : BROWSER_OUTPUT: RSS: Main: 201035776 11:02:35 INFO - 2015-11-23 11:02:35,196 DEBUG : BROWSER_OUTPUT: 11:05:37 INFO - 2015-11-23 11:05:37,726 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39633/tests/dromaeo/cssquery-prototype.html (next: http://localhost:39633/tests/dromaeo/cssquery-yui.html) 11:05:38 INFO - 2015-11-23 11:05:38,307 DEBUG : BROWSER_OUTPUT: RSS: Main: 205139968 11:05:38 INFO - 2015-11-23 11:05:38,308 DEBUG : BROWSER_OUTPUT: 11:08:40 INFO - 2015-11-23 11:08:40,973 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39633/tests/dromaeo/cssquery-yui.html (next: http://localhost:39633/tests/dromaeo/cssquery-dojo.html) 11:08:41 INFO - 2015-11-23 11:08:41,224 DEBUG : BROWSER_OUTPUT: RSS: Main: 248639488 11:08:41 INFO - 2015-11-23 11:08:41,224 DEBUG : BROWSER_OUTPUT: 11:08:41 INFO - 2015-11-23 11:08:41,225 DEBUG : BROWSER_OUTPUT: __start_tp_report 11:08:41 INFO - 2015-11-23 11:08:41,225 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 11:08:41 INFO - 2015-11-23 11:08:41,226 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 11:08:41 INFO - 2015-11-23 11:08:41,226 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 11:08:41 INFO - 2015-11-23 11:08:41,227 DEBUG : BROWSER_OUTPUT: |0;dojo.html;3185.155933677575;3242.140832679339;3287.638359780424;3294.159989202753;3304.884329048484;5292.126799078157;5383;5476.890462190754;5479.260299859523;5504.201890725847;5441.374241962176;5448.264484294619;5472.480114389136;5536.2249285100015;5584.357798853133;5004.349434573501;5084.262781896641;5107.259447380127;5151.665141765792;5184.507471790174;4963.478834722357;4968.478309777475;5018.64869459138;5068.34111565496;5099.490150177539;4922.630802689777;5017.523335283142;5031.044101620717;5056.191009438472;5082.542571168594;4899.828506002273;4971.527704868032;5022.27177059328;5036.597072234213;5061.873453163664;5010.5240002199735;5012.398512178562;5021.372328458942;5039.798408063673;5057.69653820772;5145.15105007677;5214.556762675177;5244.5017723316605;5296.09966305729;5326.6803991760235;5657.8019769307875;5793.594448388614;5796.797112101056;5796.88406231873;5844.88310233793;6067.423594758491;6071.787487437962;6081.665508397036;6082.239720034996;6093.421124993119;5388.245645609618;5471.50756431923;5483.341998960151;5632.662040277596;5634.661920284796;5930.762769489172;6043.576949613484;6048.183495228088;6051.546134039877;6077.787277445268;5881.441263080001;5881.794137205263;5887.852803679943;5888.499477544457;5892.970535147382;5634.6337488063145;5835.387284335168;5953.613015154087;5965.522758179335;5998.910016349758;5774.335951365562;5810.564207684441;5851.268591426072;5876.471117599436;5903.645781253139;5845.912311315334;5852.561057920673;5853.268341457318;5880.500157486662;5930.525557955353;4423.601875831127;4514.187446259705;4544.341070544752;4550.089982003613;4576.496585375606;3974.046228905042;4036.4752582164133;4039.4546736190237;4070.4504891839815;4092.2224777292217;5632.915506267409;5660.377358490563;5664.943350566524;5668.9716551417805;5672.4894759471845;5607.551395888319;5692.117721753135;5700.40145784695;5954.434328738763;5970.0746384310505;5533.612647114664;5635.746391412396;5638.464345887134;5641.984442800253;5677.51741102011;5138.434772175057;5169.638125331191;5207.21891716238;5213.556847667915;5233.188855727369;6234.625922444668;6266.404691554295;6270.090836828543;6277.278113016971;6278.968605156945;5675.432456754292;5732.140178973021;5734.827955161351;5776.537876969748;5984.222051133324;6155.138280640804;6157.507399407947;6159.414855588712;6162.599431037148;6167.722452489559;5821.155932389865;5868.706564671835;5871.823845284648;5884.08796636522;5963.403659634002;5644.8306550803545;5829.09649004405;5833.183354330482;5839.211706419579;5849.970750146222;5669.688167150846;5670.914936275876;5672.177534257592;5676.460736230051;5705.800296989585;5799.884002320015;5812.21535092774;5825.76696932118;5833.533317334518;5835.649861008353;5650.321961364498;5692.743826527733;5697.686627235542;5698.54411647059;5723.313202415737;5592.245046918777;5661.603687741818;5800.361960184292;5814.447627475383;5852.122181672783;5602.52378547828;5651.124075768263;5656.462636049569;5670.291213598301;5712.714639206145 11:08:41 INFO - 2015-11-23 11:08:41,229 DEBUG : BROWSER_OUTPUT: |1;ext.html;550.9283793106896;589.119266696289;606.78155863889;607.3865395950089;632.4908448698795;31565.21086972824;40652;40966.38550421739;41045.58954410455;41125.7943710281;44325.77837110818;44955.77522112393;44957;45028;45113.77443112788;7570.167281599047;7752.689892404325;8741.912580874174;8937.195652391283;10204.94897525515;10345.793084138313;10462.110720588758;10464.05823475887;10464.267501274913;10475.528601212964;10456.424896630682;10489;10536.736581585445;10561.471926403687;10563.947180264087;7813.687452501893;7975;10539.104176145036;10760.623378181726;10780.137588992862;10274.640387586473;10332;10382.79234415315;10390.636327728569;10398;40471.7976410119;40983.59016409828;40998;41018.179636407105;41026;3208.470602350609;3241.4327492688685;3548.7515873888838;3910.237503686782;3967.504061992251;31038.224044398845;31474.37051258962;31585.503794465854;32510.024699259062;32949.341013179845;3842.154725960312;3856.8842934712;3888.241792850395;3955.5253369595544;3989.2819292527333;269352;272543;273249;273530.999999998;275152;57878.7106064467;58531.41468585259;60610.18169454923;60700.69649651724;61198.38801611927;69936.65031674808;70664.6466767663;71110;71120.2887971124;71141;14912.552623421314;15083.54749357521;15091.24543772807;15095.4716584919;15126.39494420233;10777.676669699922;10875.347479151276;10886.129109671207;10895.509702063426;10919.39943303126;20021.899890500747;20159.697604535944;20178.495537611383;20231;20279.29022484206;7471.925280747231;7583.886241706379;7686.500377475558;7782.377409807202;7837.882431763528;825.5418242875141;930.6742640076054;942.5758408716105;954.5322791832091;1002.8997100289913;28560.285992850346;28587.857060714563;28968;29288.414231715247;29314.413711725647;991.2714155095998;998.9750256243652;1063.3194755356578;1118.8825173356843;1158.9826152607718;13851.238181900093;14139.928654471085;14267.78598321026;14291.713745762723;14319.642008949859;315618;319573;319746;319869;321424;51933.22100168501;52203.47796522062;52231.47768522342;52237.21644175341;52266.738666306424;1208.4018410886492;1225.2587184753274;1329.7008173160962;1341.1215653746617;1408.556304763996;27305.590416143375;28658.57012144861;28817.279568010967;29117.85441072781;29360;43893;44199.558004419545;44317.44888928872;44328.335074973256;44953.32570011387;381706;388911;389094;389230;389725;30122.24694382658;30760;30764.384712306077;30790.692093078782;30859;42120.36819447772;42549.78725106355;42642.57357426386;43439.34840977451;43568.12863742771;36605.81697091497;36932.630673693995;37128.81435592805;37300.6269937308;37645.81177094097;35409.29181416409;36486.27027459489;36581.45127823031;36833.26333473369;37177;33473.66526334705;33649.15877103092;33673;33678.326433470706;35807.641923581476;30224;30340.24149396283;30809.8459507701;30870;31032.22419439532;22278.88860555687;22566.323010309716;25332;25438.618420724073;26755.464890702468 11:08:41 INFO - 2015-11-23 11:08:41,232 DEBUG : BROWSER_OUTPUT: |2;jquery.html;359.7535688053683;363.61820088906643;364.30236097872574;364.5934782717271;365.34785408046645;14397.928010359934;14458.349374278156;16608.418705345317;16824.74762878558;17525.824741752578;10389.740256493591;10644;16467.423640172598;16944.576385590368;17005.65988680229;4795.760211989404;4903.779329930144;4905;4906.411230652327;4909.459959404463;3745.1386181178345;3840.1935593525395;4865.197242455009;4866.7566621668775;5886.705664716768;5905.232319798421;5917.55618328627;5946.137810017545;5964.88070238595;5973.790917317895;5349.679019258818;5354.678719276856;5366.221897824794;5411.83764487066;5920.644761314314;5158.793648254103;5162.74186290684;5180.8963820723375;5184;5188.481151884819;12139.575114870937;12761.361931903368;12849.843514083685;12851.678708032374;12858;1925.1144473542188;1952.7363805886307;1964.0474369930573;1977.74289342386;2089.8328133749264;9272.119148680864;9474.763130921781;9580.377275477142;12536;13071.542496012595;1818.5271829324338;1825.4979880532826;1868.6169335286233;1879.7274395212617;1882.2847318019064;59244.40755592432;60678.999999999556;60965.695171524305;61464.999999999556;62044.68977655128;9525.618975241052;9555.474448905377;9623.182029527568;9717.59094931245;9877.456739879231;12226.816597751042;12262;12281.140320177681;12296.20074695142;12313.753724925451;7026.297370263035;7286;7297.562146271241;7465.477416580896;7624.466287359832;6859.622720750307;6871;6898.896516552155;6908.585484870924;6916.20463646677;4018.176273863851;4058.0463591056077;4070.653994410449;4206.831726730958;4323.308270676676;1690.797104347486;1713.2461716844548;1744.2499725118066;1757.789065312145;1784.732290156461;404.1512823071585;409.09181616810633;953.3469573342283;1034.534459493216;1048.5229220704562;8806.339524535686;9992.650257241106;10696.090832279344;10889.074428673652;11023.283486573348;420.11356038758197;428.5992596921888;431.6503632058043;442.0716495359783;455.0466772112419;5649.858753531194;5779.162021506858;5858.209141765892;5884.176215329857;5895.823125306248;514359.77604522987;526386;529394;536326;536625;78897;79139.20860791318;80979.59510202412;81330;82926.17073829305;482.1369748150771;486.7104073076514;487.1863987141482;487.6513292995525;488.7776061891831;10081.344712593658;10114.747131321776;10168.853676652638;10181.185505159718;10183;32350.19124521906;32621.347573047933;33020.1744956378;33791.324173516885;33907;45287.77356113198;46284.53715462937;46460.30309545427;46951;47648.523514765795;8803.823923521366;9037.77405564866;9117.863232051392;9280.814383712423;9311;10704.571817127227;11914.702132446411;17512.474625761246;17785.28858845632;17969.73045404346;14108.153510788974;14185.432582696576;14301.427942882168;14607.92696036513;15002.924985375003;14015.50945716895;14061.578152655436;14381.568552943429;14426.639334016734;14529.288337993403;11473.942630286796;11867.762644746885;13157.276349800853;14091.295435228403;14584.927075364556;8635.179657932485;8648.1784230498;9014.2788576915;9407.764805879908;9423.81152376935;9517.571709273238;14212.644683882985;14234.074785138933;14325.426982920982;14531.200783956561 11:08:41 INFO - 2015-11-23 11:08:41,232 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1324.4834514539325;1718.3556166437584;1742.3901634427953;1766.3376233912284;1774.3878361965126;6495.058216558602;7515.924840751591;7683.270089341518;7690.115636701788;7701.306882380599;7423.1092268927805;7554.773356799291;7555.735549255777;7559.69761209551;7562.281583249596;1954.1694779718634;1986.016921623791;2239.2274665240466;2243.6858839762444;2262.7850354216407;2281.6805647209403;2286.0969916882823;2286.1541229744935;2286.3369622809364;2287.565362581104;2209.0501084533644;2261.2650888461317;2267.886605669718;2271.3980795089315;2285.531466049464;1873.9812601874012;1929.4790406590212;2197.8351623628214;2232.096001119533;2243.2933625907785;2284.280451657739;2292.9197478088186;2319.373769082338;2319.9652005219937;2321.9651705224437;7660.348870346027;7733.7679869604;7734.110577283572;7734.110577283628;7750.341220996222;4572.359869618256;4660.231061874787;4676.766161691936;4679.040796636681;4680.3447517347595;2964.318206812445;3021.5165573508352;3054.923626909345;3063.754899608048;3076.461619216628;914.0813482450161;920.8664743612205;925.3892430995578;937.5031233446284;939;10598.682039538826;10608.15134789215;10611.416372099531;10615.363078215254;10620.203484738675;4117.641178411117;4148.979255103705;4196.790160491963;4284.378765079046;4293.3989241506215;8938.46369217849;8991.685291014914;9040.095990400907;9049.140331668481;9062.275017998545;4626.930596041062;4653.2554791233915;4694.976525117421;4696.03731235096;4701.95298047022;4240.851570195028;4246.256905041667;4247.129338485664;4248.681348898845;4250.829966801355;3673.3571624966057;3725.4970578972034;3730.9440358394645;3745.8127093645207;3758.0604848787802;1240.1938739819009;1244.2658831289582;1249.5064449542563;1252.8183413405188;1254.799232122856;1229.8339724137306;1243.8569564500199;1257.798752199662;1269.6698858296909;1270.7140893298933;6467;6714.3957043866285;7234.385077268385;7352.154502232205;7405.1854296027395;567.6367125039977;568.7668056097064;573.383612616439;597.554821657859;601.5458328961694;5685.232493613309;5688.800891968761;5693.430656934356;5733.197352370671;5736.4550367715;8987.775305617412;9057.09429057089;9264.166225039779;9275.0261222572;9315.48764817928;8981.775455613662;9000.819983600291;9126.771830704152;9163.954180229057;9166.037566055467;7000.544964577286;7165.462590305748;7175.928240717526;7269.164046134762;7270.091238595176;6936.890097584363;6940.09778728762;6982.301769822977;6985.301469853177;6987.266337034538;7937.563434011185;8127.837443250984;8201.42590018693;8233.629486673233;8293.377996650155;8300.252977232078;8447.113053129333;8451.577421129043;8464.195901389357;8472.19514146155;6738.696758645775;6829.521933464808;6853.040574319699;6854.383105520327;6866.313368663094;7249;7274.236205198378;7294.854102918018;7303.050603421521;7306;6700.329967003456;6819.249882513019;6826.351496607815;6943.236244013256;6980.406665433495;6720.731170753115;6764.864702706017;6796.048553202654;6805.04729337903;6852.383285504328;6191.752329906753;6293.213348331458;6350.7777227796805;6431.935680643321;6614.867702645824;5979.5814292999075;6219.968900155471;6268.404501572343;6276.466500347339;6297.779577714941;6288.654124023223;6327.905081423874;6333.20834895638;6337.081123237197;6338.144350512622 11:08:41 INFO - 2015-11-23 11:08:41,236 DEBUG : BROWSER_OUTPUT: |4;prototype.html;333.41319278070597;334.9045522026223;338.7290167865707;338.90171850163455;342.1787709497208;6103.603265787732;6104.6947652617355;6110.602810817294;6176.382361763822;6188.752449902004;6036.154938308629;6069.484093852028;6070.969645151768;6075.2405949256345;6100.481459075984;4676.205045142334;4697.553732395434;4701.976490117545;4707;4707.082118986799;4467.262901621229;4596.54034596541;4606.677532572721;4613.953860461403;4618.630509559227;4534.79593418297;4539.024109816389;4551.112533056039;4554.0664163846495;4554.134714404253;4416.470023597157;4472.016156445577;4489.169503641837;4549.24937385331;4549.931751023721;3958.762474251554;3965.8215380307665;3976.224636195943;3986.362182050887;3991.2815693175216;5698.857528561778;5703.287089113861;5711.086226203787;5731.083026715705;5738.139279108167;5030;5120.718360490171;5160.974195129038;5211.166213405837;5352.625316227865;6380.7128679209545;6382.968085159591;6387.776427825051;6398.360163983564;6401.679916004181;4396.494403143647;4403.185410699031;4407;4409.184300904343;4409.536998615164;6531.216254049497;6623.172103487064;6690.899636505407;6691.230508491537;6701.396874281338;4475.30632751924;4512.052468981485;4516.841910533116;4517.954820451753;4518.638508919278;4524.434445694288;4530.728156310632;4532.297493888453;4561.315802629632;4574.931376029363;5267.2889159962915;5305.389880163753;5316.7075810830775;5318.547923426475;5330.440303768049;6274.247090349188;6426.678666066771;6446.9040263155375;6478.352164783578;6479.6760161991715;1594.0913679202743;1601.7597360396035;1603.7033148867497;1605.389951818325;1605.8073031236092;1050.2543194332109;1056.2817284246632;1061.2836335473523;1061.6974162363845;1079.956801727922;6293.370662933761;6295.276043255084;6301.7164227609865;6306.400891915261;6308.589941653778;6686.96656516724;6687.665616719145;6687.899681504781;6693.263740988487;6700.631465269457;6163.722632481549;6308.968455157695;6321.462675672619;6321.589096708699;6326.588771729823;3615.096225943514;3635.4365073413665;3635.6727894489622;3642.5446819147605;3644.325799727006;6952.652367381611;6973.232944376115;6982.720691172296;6986.196587392515;6992.2658120897595;6543.247526534509;6654.201495820435;6772.55978361405;6805.557638753465;6808.489363297773;6771.627560484122;6948.861022779617;6954.4436445084275;6960.721571137199;6968.790936271818;6560.245571759308;6644.734210631714;6649.73401063952;6708.765193218214;6729.730810767514;6520.836979075561;6669.866602667822;6672.266050734318;6681.365270299314;6683.097781799589;7040.823979400556;7053.435725142079;7054.153501579844;7058.5764854106865;7059.364657180879;4512.097580483982;4515.34527493505;4519.683622146418;4523.705959112647;4529.977350113229;6714;6716.227633821977;6717.529772916045;6724.092247546519;6727.596344219362;6375.74497020114;6601.075849380994;6601.075849381186;6611.636360000246;6620.3710647488415;6562.80311590653;6579.605223686594;6582.243042050034;6586.868262634624;6597.439217666552;6240.687965601793;6466.708998095003;6475.417212450902;6478.838029049123;6486.091947127312;6599.53803233769;6599.967000164968;6601.801945941629;6607.372299631527;6609.10777045112;6430.614163150226;6435.903461447989;6441.323661015525;6443.96778016107;6447.4197322241225 11:08:41 INFO - 2015-11-23 11:08:41,236 DEBUG : BROWSER_OUTPUT: |5;yui.html;658.2232965101178;658.5719282466396;834.6452757578029;840.8402403543326;851.7479305421028;13783.931080344597;14079.92960035201;14149.151050936951;14224.288785560719;14238.288085595705;13106;13159.605211843636;13190;13195;13196.670083247924;668.1447746883972;676.1210426445625;805.6495424490336;822.7490615362312;823.3618945317397;804.4288555125868;806.9031716194036;813.276184196066;814.4176913506841;815.9918400816005;845.8773477845708;856.1566856646199;856.3448961544424;856.4604299291437;856.6830272799042;703.0824773670358;709.0569542508451;838.7693384319361;847.8982522097357;849.7918010087568;621.3258614403333;622.3869488553771;624.3007831229007;624.7407325959721;625.3933684326196;12906.161099528501;13036;13068.803967940488;13078.280694561796;13078.411471483807;11555.76888462226;11800.46897889597;11863.347515886622;12094.637160885188;12479.376031198495;9879.407235565817;10069.949650251776;10319.638812641522;10374.948125259401;10493.842592361121;3528.576570811493;3532.3818331791836;3545.2023294758733;3558.5551806024246;3699.445083237509;49878.96839232195;50550;50870.23694644583;51555.96888062255;51738.7413062936;9077.77305567353;9127.634894604142;9146.724342426456;9248;9386.296027797942;15778;15832.050076995418;15861.04833709958;15866.127362994916;15909.920450397674;6853.760118395832;7005.194402643761;7105.715771369088;7126.572405655677;7322.816929576697;4237.936430953539;4238.109996900624;4243.575642435731;4400.075984043387;4440.533743956838;3162.5730526378643;3193.1378527797365;3195.5526226328334;3204.07081946233;3210.29373537826;560.3052215253139;570.8173384516998;578.0635370699409;587.3949831673383;588.5791658963776;578.6817250512202;603.230880627195;628.1237673445518;645.3739872323838;654.2084078265257;8062.7422878441;8223.794405139919;8286.751397457965;8398.202170793766;8551.486910785372;570.1704020650027;603.8912995660735;648.1638686094885;655.7311502284041;659.4131223211346;3652.6895213907114;3932.9213415732097;3988.441618173458;4002.3918676500134;4002.6397624213378;61809.69095154495;61819.690901545204;61948.38051619516;62032.37967620266;62122.378776212565;53931.730341348826;53999.19001214985;54343.45656543463;54501.45498545043;55104.448955509935;48002.759986200545;48063;48123.75938120287;48390.75804620954;49282.50717492779;7763.28887119247;7864.803379915548;7929.960350198212;8000.639971201426;8057.637406316612;34070.318593628486;34307.82846085853;34590.13524661803;34741;34887.476687849194;43966.56033439752;44309.33535997027;45397.31904021376;47262.76368618135;47490;9509.809803804024;9643.228541716506;9828.11546960777;10180.592776288866;10188.745281368025;11707.356095414834;11919.642410727693;11920.344381059125;12505.187162834387;12569.371531423576;11174.776504469703;11438.599649012245;11582.6525204244;11681;11959.162858599815;11099.44502774842;11406.714832129263;11549.942250288696;11802.82295765547;11810.291382516732;10440.56276082677;10816.837747433638;11128.276662016942;11340.262882912584;11416;8915.643374264957;9162.541872906195;9249.676261330822;9397.201237894855;9454.628735300366;8815.382923195315;9034.774130646523;9187.862182067409;9258.490783006999;9346.299027572823 11:08:41 INFO - 2015-11-23 11:08:41,236 DEBUG : BROWSER_OUTPUT: __end_tp_report 11:08:41 INFO - 2015-11-23 11:08:41,236 DEBUG : BROWSER_OUTPUT: __start_cc_report 11:08:41 INFO - 2015-11-23 11:08:41,236 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,1337 11:08:41 INFO - 2015-11-23 11:08:41,237 DEBUG : BROWSER_OUTPUT: __end_cc_report 11:08:41 INFO - 2015-11-23 11:08:41,237 DEBUG : BROWSER_OUTPUT: __startTimestamp1448305721224__endTimestamp 11:08:41 INFO - 2015-11-23 11:08:41,237 DEBUG : BROWSER_OUTPUT: 11:08:41 INFO - 2015-11-23 11:08:41,237 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 11:08:41 INFO - 2015-11-23 11:08:41,237 DEBUG : BROWSER_OUTPUT: Number of tests: 6 11:08:41 INFO - 2015-11-23 11:08:41,237 DEBUG : BROWSER_OUTPUT: 11:08:41 INFO - 2015-11-23 11:08:41,237 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:5479.11 Median:5668.97 stddev:615.05 (10.8%) stddev-sans-first:590.02 11:08:41 INFO - 2015-11-23 11:08:41,239 DEBUG : BROWSER_OUTPUT: Values: 3185.2 3242.1 3287.6 3294.2 3304.9 5292.1 5383.0 5476.9 5479.3 5504.2 5441.4 5448.3 5472.5 5536.2 5584.4 5004.3 5084.3 5107.3 5151.7 5184.5 4963.5 4968.5 5018.6 5068.3 5099.5 4922.6 5017.5 5031.0 5056.2 5082.5 4899.8 4971.5 5022.3 5036.6 5061.9 5010.5 5012.4 5021.4 5039.8 5057.7 5145.2 5214.6 5244.5 5296.1 5326.7 5657.8 5793.6 5796.8 5796.9 5844.9 6067.4 6071.8 6081.7 6082.2 6093.4 5388.2 5471.5 5483.3 5632.7 5634.7 5930.8 6043.6 6048.2 6051.5 6077.8 5881.4 5881.8 5887.9 5888.5 5893.0 5634.6 5835.4 5953.6 5965.5 5998.9 5774.3 5810.6 5851.3 5876.5 5903.6 5845.9 5852.6 5853.3 5880.5 5930.5 4423.6 4514.2 4544.3 4550.1 4576.5 3974.0 4036.5 4039.5 4070.5 4092.2 5632.9 5660.4 5664.9 5669.0 5672.5 5607.6 5692.1 5700.4 5954.4 5970.1 5533.6 5635.7 5638.5 5642.0 5677.5 5138.4 5169.6 5207.2 5213.6 5233.2 6234.6 6266.4 6270.1 6277.3 6279.0 5675.4 5732.1 5734.8 5776.5 5984.2 6155.1 6157.5 6159.4 6162.6 6167.7 5821.2 5868.7 5871.8 5884.1 5963.4 5644.8 5829.1 5833.2 5839.2 5850.0 5669.7 5670.9 5672.2 5676.5 5705.8 5799.9 5812.2 5825.8 5833.5 5835.6 5650.3 5692.7 5697.7 5698.5 5723.3 5592.2 5661.6 5800.4 5814.4 5852.1 5602.5 5651.1 5656.5 5670.3 5712.7 11:08:41 INFO - 2015-11-23 11:08:41,239 DEBUG : BROWSER_OUTPUT: 11:08:41 INFO - 2015-11-23 11:08:41,239 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:49621.83 Median:33211.50 stddev:86673.71 (261.0%) stddev-sans-first:86838.55 11:08:41 INFO - 2015-11-23 11:08:41,239 DEBUG : BROWSER_OUTPUT: Values: 550.9 589.1 606.8 607.4 632.5 31565.2 40652.0 40966.4 41045.6 41125.8 44325.8 44955.8 44957.0 45028.0 45113.8 7570.2 7752.7 8741.9 8937.2 10204.9 10345.8 10462.1 10464.1 10464.3 10475.5 10456.4 10489.0 10536.7 10561.5 10563.9 7813.7 7975.0 10539.1 10760.6 10780.1 10274.6 10332.0 10382.8 10390.6 10398.0 40471.8 40983.6 40998.0 41018.2 41026.0 3208.5 3241.4 3548.8 3910.2 3967.5 31038.2 31474.4 31585.5 32510.0 32949.3 3842.2 3856.9 3888.2 3955.5 3989.3 269352.0 272543.0 273249.0 273531.0 275152.0 57878.7 58531.4 60610.2 60700.7 61198.4 69936.7 70664.6 71110.0 71120.3 71141.0 14912.6 15083.5 15091.2 15095.5 15126.4 10777.7 10875.3 10886.1 10895.5 10919.4 20021.9 20159.7 20178.5 20231.0 20279.3 7471.9 7583.9 7686.5 7782.4 7837.9 825.5 930.7 942.6 954.5 1002.9 28560.3 28587.9 28968.0 29288.4 29314.4 991.3 999.0 1063.3 1118.9 1159.0 13851.2 14139.9 14267.8 14291.7 14319.6 315618.0 319573.0 319746.0 319869.0 321424.0 51933.2 52203.5 52231.5 52237.2 52266.7 1208.4 1225.3 1329.7 1341.1 1408.6 27305.6 28658.6 28817.3 29117.9 29360.0 43893.0 44199.6 44317.4 44328.3 44953.3 381706.0 388911.0 389094.0 389230.0 389725.0 30122.2 30760.0 30764.4 30790.7 30859.0 42120.4 42549.8 42642.6 43439.3 43568.1 36605.8 36932.6 37128.8 37300.6 37645.8 35409.3 36486.3 36581.5 36833.3 37177.0 33473.7 33649.2 33673.0 33678.3 35807.6 30224.0 30340.2 30809.8 30870.0 31032.2 22278.9 22566.3 25332.0 25438.6 26755.5 11:08:41 INFO - 2015-11-23 11:08:41,239 DEBUG : BROWSER_OUTPUT: 11:08:41 INFO - 2015-11-23 11:08:41,239 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:27563.37 Median:430.12 stddev:86571.72 (20127.1%) stddev-sans-first:86790.48 11:08:41 INFO - 2015-11-23 11:08:41,240 DEBUG : BROWSER_OUTPUT: Values: 359.8 363.6 364.3 364.6 365.3 14397.9 14458.3 16608.4 16824.7 17525.8 10389.7 10644.0 16467.4 16944.6 17005.7 4795.8 4903.8 4905.0 4906.4 4909.5 3745.1 3840.2 4865.2 4866.8 5886.7 5905.2 5917.6 5946.1 5964.9 5973.8 5349.7 5354.7 5366.2 5411.8 5920.6 5158.8 5162.7 5180.9 5184.0 5188.5 12139.6 12761.4 12849.8 12851.7 12858.0 1925.1 1952.7 1964.0 1977.7 2089.8 9272.1 9474.8 9580.4 12536.0 13071.5 1818.5 1825.5 1868.6 1879.7 1882.3 59244.4 60679.0 60965.7 61465.0 62044.7 9525.6 9555.5 9623.2 9717.6 9877.5 12226.8 12262.0 12281.1 12296.2 12313.8 7026.3 7286.0 7297.6 7465.5 7624.5 6859.6 6871.0 6898.9 6908.6 6916.2 4018.2 4058.0 4070.7 4206.8 4323.3 1690.8 1713.2 1744.2 1757.8 1784.7 404.2 409.1 953.3 1034.5 1048.5 8806.3 9992.7 10696.1 10889.1 11023.3 420.1 428.6 431.7 442.1 455.0 5649.9 5779.2 5858.2 5884.2 5895.8 514359.8 526386.0 529394.0 536326.0 536625.0 78897.0 79139.2 80979.6 81330.0 82926.2 482.1 486.7 487.2 487.7 488.8 10081.3 10114.7 10168.9 10181.2 10183.0 32350.2 32621.3 33020.2 33791.3 33907.0 45287.8 46284.5 46460.3 46951.0 47648.5 8803.8 9037.8 9117.9 9280.8 9311.0 10704.6 11914.7 17512.5 17785.3 17969.7 14108.2 14185.4 14301.4 14607.9 15002.9 14015.5 14061.6 14381.6 14426.6 14529.3 11473.9 11867.8 13157.3 14091.3 14584.9 8635.2 8648.2 9014.3 9407.8 9423.8 9517.6 14212.6 14234.1 14325.4 14531.2 11:08:41 INFO - 2015-11-23 11:08:41,241 DEBUG : BROWSER_OUTPUT: 11:08:41 INFO - 2015-11-23 11:08:41,241 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5333.61 Median:6290.93 stddev:2767.88 (44.0%) stddev-sans-first:2759.24 11:08:41 INFO - 2015-11-23 11:08:41,241 DEBUG : BROWSER_OUTPUT: Values: 1324.5 1718.4 1742.4 1766.3 1774.4 6495.1 7515.9 7683.3 7690.1 7701.3 7423.1 7554.8 7555.7 7559.7 7562.3 1954.2 1986.0 2239.2 2243.7 2262.8 2281.7 2286.1 2286.2 2286.3 2287.6 2209.1 2261.3 2267.9 2271.4 2285.5 1874.0 1929.5 2197.8 2232.1 2243.3 2284.3 2292.9 2319.4 2320.0 2322.0 7660.3 7733.8 7734.1 7734.1 7750.3 4572.4 4660.2 4676.8 4679.0 4680.3 2964.3 3021.5 3054.9 3063.8 3076.5 914.1 920.9 925.4 937.5 939.0 10598.7 10608.2 10611.4 10615.4 10620.2 4117.6 4149.0 4196.8 4284.4 4293.4 8938.5 8991.7 9040.1 9049.1 9062.3 4626.9 4653.3 4695.0 4696.0 4702.0 4240.9 4246.3 4247.1 4248.7 4250.8 3673.4 3725.5 3730.9 3745.8 3758.1 1240.2 1244.3 1249.5 1252.8 1254.8 1229.8 1243.9 1257.8 1269.7 1270.7 6467.0 6714.4 7234.4 7352.2 7405.2 567.6 568.8 573.4 597.6 601.5 5685.2 5688.8 5693.4 5733.2 5736.5 8987.8 9057.1 9264.2 9275.0 9315.5 8981.8 9000.8 9126.8 9164.0 9166.0 7000.5 7165.5 7175.9 7269.2 7270.1 6936.9 6940.1 6982.3 6985.3 6987.3 7937.6 8127.8 8201.4 8233.6 8293.4 8300.3 8447.1 8451.6 8464.2 8472.2 6738.7 6829.5 6853.0 6854.4 6866.3 7249.0 7274.2 7294.9 7303.1 7306.0 6700.3 6819.2 6826.4 6943.2 6980.4 6720.7 6764.9 6796.0 6805.0 6852.4 6191.8 6293.2 6350.8 6431.9 6614.9 5979.6 6220.0 6268.4 6276.5 6297.8 6288.7 6327.9 6333.2 6337.1 6338.1 11:08:41 INFO - 2015-11-23 11:08:41,241 DEBUG : BROWSER_OUTPUT: 11:08:41 INFO - 2015-11-23 11:08:41,241 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:5399.06 Median:6214.72 stddev:1659.39 (26.7%) stddev-sans-first:1619.90 11:08:41 INFO - 2015-11-23 11:08:41,241 DEBUG : BROWSER_OUTPUT: Values: 333.4 334.9 338.7 338.9 342.2 6103.6 6104.7 6110.6 6176.4 6188.8 6036.2 6069.5 6071.0 6075.2 6100.5 4676.2 4697.6 4702.0 4707.0 4707.1 4467.3 4596.5 4606.7 4614.0 4618.6 4534.8 4539.0 4551.1 4554.1 4554.1 4416.5 4472.0 4489.2 4549.2 4549.9 3958.8 3965.8 3976.2 3986.4 3991.3 5698.9 5703.3 5711.1 5731.1 5738.1 5030.0 5120.7 5161.0 5211.2 5352.6 6380.7 6383.0 6387.8 6398.4 6401.7 4396.5 4403.2 4407.0 4409.2 4409.5 6531.2 6623.2 6690.9 6691.2 6701.4 4475.3 4512.1 4516.8 4518.0 4518.6 4524.4 4530.7 4532.3 4561.3 4574.9 5267.3 5305.4 5316.7 5318.5 5330.4 6274.2 6426.7 6446.9 6478.4 6479.7 1594.1 1601.8 1603.7 1605.4 1605.8 1050.3 1056.3 1061.3 1061.7 1080.0 6293.4 6295.3 6301.7 6306.4 6308.6 6687.0 6687.7 6687.9 6693.3 6700.6 6163.7 6309.0 6321.5 6321.6 6326.6 3615.1 3635.4 3635.7 3642.5 3644.3 6952.7 6973.2 6982.7 6986.2 6992.3 6543.2 6654.2 6772.6 6805.6 6808.5 6771.6 6948.9 6954.4 6960.7 6968.8 6560.2 6644.7 6649.7 6708.8 6729.7 6520.8 6669.9 6672.3 6681.4 6683.1 7040.8 7053.4 7054.2 7058.6 7059.4 4512.1 4515.3 4519.7 4523.7 4530.0 6714.0 6716.2 6717.5 6724.1 6727.6 6375.7 6601.1 6601.1 6611.6 6620.4 6562.8 6579.6 6582.2 6586.9 6597.4 6240.7 6466.7 6475.4 6478.8 6486.1 6599.5 6600.0 6601.8 6607.4 6609.1 6430.6 6435.9 6441.3 6444.0 6447.4 11:08:41 INFO - 2015-11-23 11:08:41,241 DEBUG : BROWSER_OUTPUT: 11:08:41 INFO - 2015-11-23 11:08:41,242 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:13960.43 Median:52835.24 stddev:16849.33 (31.9%) stddev-sans-first:16866.99 11:08:41 INFO - 2015-11-23 11:08:41,243 DEBUG : BROWSER_OUTPUT: Values: 658.2 658.6 834.6 840.8 851.7 13783.9 14079.9 14149.2 14224.3 14238.3 13106.0 13159.6 13190.0 13195.0 13196.7 668.1 676.1 805.6 822.7 823.4 804.4 806.9 813.3 814.4 816.0 845.9 856.2 856.3 856.5 856.7 703.1 709.1 838.8 847.9 849.8 621.3 622.4 624.3 624.7 625.4 12906.2 13036.0 13068.8 13078.3 13078.4 11555.8 11800.5 11863.3 12094.6 12479.4 9879.4 10069.9 10319.6 10374.9 10493.8 3528.6 3532.4 3545.2 3558.6 3699.4 49879.0 50550.0 50870.2 51556.0 51738.7 9077.8 9127.6 9146.7 9248.0 9386.3 15778.0 15832.1 15861.0 15866.1 15909.9 6853.8 7005.2 7105.7 7126.6 7322.8 4237.9 4238.1 4243.6 4400.1 4440.5 3162.6 3193.1 3195.6 3204.1 3210.3 560.3 570.8 578.1 587.4 588.6 578.7 603.2 628.1 645.4 654.2 8062.7 8223.8 8286.8 8398.2 8551.5 570.2 603.9 648.2 655.7 659.4 3652.7 3932.9 3988.4 4002.4 4002.6 61809.7 61819.7 61948.4 62032.4 62122.4 53931.7 53999.2 54343.5 54501.5 55104.4 48002.8 48063.0 48123.8 48390.8 49282.5 7763.3 7864.8 7930.0 8000.6 8057.6 34070.3 34307.8 34590.1 34741.0 34887.5 43966.6 44309.3 45397.3 47262.8 47490.0 9509.8 9643.2 9828.1 10180.6 10188.7 11707.4 11919.6 11920.3 12505.2 12569.4 11174.8 11438.6 11582.7 11681.0 11959.2 11099.4 11406.7 11549.9 11802.8 11810.3 10440.6 10816.8 11128.3 11340.3 11416.0 8915.6 9162.5 9249.7 9397.2 9454.6 8815.4 9034.8 9187.9 9258.5 9346.3 11:08:41 INFO - 2015-11-23 11:08:41,243 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 11:08:41 INFO - 2015-11-23 11:08:41,243 DEBUG : BROWSER_OUTPUT: 11:08:41 INFO - 2015-11-23 11:08:41,898 INFO : Browser exited with error code: 0 11:08:41 INFO - 2015-11-23 11:08:41,917 INFO : Completed test dromaeo_css (00:18:33) 11:08:41 INFO - 2015-11-23 11:08:41,917 INFO : Starting test kraken 11:08:41 INFO - 2015-11-23 11:08:41,917 DEBUG : operating with platform_type : linux_ 11:08:41 INFO - 2015-11-23 11:08:41,917 INFO : Initialising browser for kraken test... 11:08:41 INFO - 2015-11-23 11:08:41,923 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpSPYwwu/profile http://localhost:39633/getInfo.html 11:08:45 INFO - 2015-11-23 11:08:45,448 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 11:08:45 INFO - 2015-11-23 11:08:45,448 DEBUG : BROWSER_OUTPUT: colorDepth:24 11:08:45 INFO - 2015-11-23 11:08:45,448 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 11:08:45 INFO - 2015-11-23 11:08:45,448 DEBUG : BROWSER_OUTPUT: __metrics 11:08:45 INFO - 2015-11-23 11:08:45,565 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 11:08:46 INFO - 2015-11-23 11:08:46,794 INFO : Browser initialized. 11:08:46 INFO - 2015-11-23 11:08:46,794 INFO : Running cycle 1/1 for kraken test... 11:08:46 INFO - 2015-11-23 11:08:46,795 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpSPYwwu/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 11:08:58 INFO - 2015-11-23 11:08:58,506 DEBUG : BROWSER_OUTPUT: RSS: Main: 141815808 11:08:58 INFO - 2015-11-23 11:08:58,506 DEBUG : BROWSER_OUTPUT: 11:09:00 INFO - 2015-11-23 11:09:00,932 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39633/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:39633/tests/kraken/driver.html?testName=audio-beat-detection) 11:09:01 INFO - 2015-11-23 11:09:01,515 DEBUG : BROWSER_OUTPUT: RSS: Main: 179523584 11:09:01 INFO - 2015-11-23 11:09:01,515 DEBUG : BROWSER_OUTPUT: 11:09:04 INFO - 2015-11-23 11:09:04,084 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39633/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:39633/tests/kraken/driver.html?testName=audio-dft) 11:09:04 INFO - 2015-11-23 11:09:04,653 DEBUG : BROWSER_OUTPUT: RSS: Main: 170479616 11:09:04 INFO - 2015-11-23 11:09:04,653 DEBUG : BROWSER_OUTPUT: 11:09:07 INFO - 2015-11-23 11:09:07,516 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39633/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:39633/tests/kraken/driver.html?testName=audio-fft) 11:09:08 INFO - 2015-11-23 11:09:08,077 DEBUG : BROWSER_OUTPUT: RSS: Main: 150482944 11:09:08 INFO - 2015-11-23 11:09:08,078 DEBUG : BROWSER_OUTPUT: 11:09:10 INFO - 2015-11-23 11:09:10,075 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39633/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:39633/tests/kraken/driver.html?testName=audio-oscillator) 11:09:10 INFO - 2015-11-23 11:09:10,636 DEBUG : BROWSER_OUTPUT: RSS: Main: 152805376 11:09:10 INFO - 2015-11-23 11:09:10,636 DEBUG : BROWSER_OUTPUT: 11:09:12 INFO - 2015-11-23 11:09:12,810 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39633/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:39633/tests/kraken/driver.html?testName=imaging-gaussian-blur) 11:09:13 INFO - 2015-11-23 11:09:13,371 DEBUG : BROWSER_OUTPUT: RSS: Main: 155914240 11:09:13 INFO - 2015-11-23 11:09:13,372 DEBUG : BROWSER_OUTPUT: 11:09:16 INFO - 2015-11-23 11:09:16,322 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39633/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:39633/tests/kraken/driver.html?testName=imaging-darkroom) 11:09:16 INFO - 2015-11-23 11:09:16,890 DEBUG : BROWSER_OUTPUT: RSS: Main: 156487680 11:09:16 INFO - 2015-11-23 11:09:16,890 DEBUG : BROWSER_OUTPUT: 11:09:20 INFO - 2015-11-23 11:09:20,280 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39633/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:39633/tests/kraken/driver.html?testName=imaging-desaturate) 11:09:20 INFO - 2015-11-23 11:09:20,852 DEBUG : BROWSER_OUTPUT: RSS: Main: 156069888 11:09:20 INFO - 2015-11-23 11:09:20,852 DEBUG : BROWSER_OUTPUT: 11:09:23 INFO - 2015-11-23 11:09:23,596 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39633/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:39633/tests/kraken/driver.html?testName=json-parse-financial) 11:09:24 INFO - 2015-11-23 11:09:24,177 DEBUG : BROWSER_OUTPUT: RSS: Main: 157044736 11:09:24 INFO - 2015-11-23 11:09:24,177 DEBUG : BROWSER_OUTPUT: 11:09:25 INFO - 2015-11-23 11:09:25,713 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39633/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:39633/tests/kraken/driver.html?testName=json-stringify-tinderbox) 11:09:26 INFO - 2015-11-23 11:09:26,274 DEBUG : BROWSER_OUTPUT: RSS: Main: 167190528 11:09:26 INFO - 2015-11-23 11:09:26,275 DEBUG : BROWSER_OUTPUT: 11:09:28 INFO - 2015-11-23 11:09:28,065 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39633/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:39633/tests/kraken/driver.html?testName=stanford-crypto-aes) 11:09:28 INFO - 2015-11-23 11:09:28,666 DEBUG : BROWSER_OUTPUT: RSS: Main: 166670336 11:09:28 INFO - 2015-11-23 11:09:28,667 DEBUG : BROWSER_OUTPUT: 11:09:30 INFO - 2015-11-23 11:09:30,698 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39633/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:39633/tests/kraken/driver.html?testName=stanford-crypto-ccm) 11:09:31 INFO - 2015-11-23 11:09:31,267 DEBUG : BROWSER_OUTPUT: RSS: Main: 171737088 11:09:31 INFO - 2015-11-23 11:09:31,268 DEBUG : BROWSER_OUTPUT: 11:09:33 INFO - 2015-11-23 11:09:33,662 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39633/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:39633/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 11:09:34 INFO - 2015-11-23 11:09:34,243 DEBUG : BROWSER_OUTPUT: RSS: Main: 180715520 11:09:34 INFO - 2015-11-23 11:09:34,243 DEBUG : BROWSER_OUTPUT: 11:09:36 INFO - 2015-11-23 11:09:36,778 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39633/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:39633/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 11:09:37 INFO - 2015-11-23 11:09:37,341 DEBUG : BROWSER_OUTPUT: RSS: Main: 177840128 11:09:37 INFO - 2015-11-23 11:09:37,342 DEBUG : BROWSER_OUTPUT: 11:09:39 INFO - 2015-11-23 11:09:39,012 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39633/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:39633/tests/kraken/driver.html?testName=ai-astar) 11:09:39 INFO - 2015-11-23 11:09:39,257 DEBUG : BROWSER_OUTPUT: RSS: Main: 236908544 11:09:39 INFO - 2015-11-23 11:09:39,258 DEBUG : BROWSER_OUTPUT: 11:09:39 INFO - 2015-11-23 11:09:39,261 DEBUG : BROWSER_OUTPUT: __start_tp_report 11:09:39 INFO - 2015-11-23 11:09:39,261 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 11:09:39 INFO - 2015-11-23 11:09:39,261 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 11:09:39 INFO - 2015-11-23 11:09:39,261 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 11:09:39 INFO - 2015-11-23 11:09:39,262 DEBUG : BROWSER_OUTPUT: |0;ai-astar;108;109;103;109;109;110;100;111;109;97 11:09:39 INFO - 2015-11-23 11:09:39,262 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;153;123;150;159;124;151;147;133;157;122 11:09:39 INFO - 2015-11-23 11:09:39,262 DEBUG : BROWSER_OUTPUT: |2;audio-dft;161;167;160;159;162;161;158;162;165;161 11:09:39 INFO - 2015-11-23 11:09:39,262 DEBUG : BROWSER_OUTPUT: |3;audio-fft;72;71;85;98;73;71;72;108;94;71 11:09:39 INFO - 2015-11-23 11:09:39,262 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;92;92;133;92;93;92;137;93;93;134 11:09:39 INFO - 2015-11-23 11:09:39,262 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;110;110;109;109;109;109;110;109;110;109 11:09:39 INFO - 2015-11-23 11:09:39,262 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;145;147;146;146;146;145;147;146;146;146 11:09:39 INFO - 2015-11-23 11:09:39,263 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;96;96;96;96;96;97;96;95;96;96 11:09:39 INFO - 2015-11-23 11:09:39,263 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;57;59;56;56;56;57;57;58;56;54 11:09:39 INFO - 2015-11-23 11:09:39,263 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;68;68;68;68;69;69;69;69;69;69 11:09:39 INFO - 2015-11-23 11:09:39,263 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;84;85;84;84;83;84;84;83;84;84 11:09:39 INFO - 2015-11-23 11:09:39,263 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;119;120;127;118;121;116;120;119;117;120 11:09:39 INFO - 2015-11-23 11:09:39,263 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;139;150;154;148;149;149;148;148;146;138 11:09:39 INFO - 2015-11-23 11:09:39,263 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;65;69;68;66;67;65;66;68;69;68 11:09:39 INFO - 2015-11-23 11:09:39,264 DEBUG : BROWSER_OUTPUT: __end_tp_report 11:09:39 INFO - 2015-11-23 11:09:39,264 DEBUG : BROWSER_OUTPUT: __start_cc_report 11:09:39 INFO - 2015-11-23 11:09:39,264 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,900 11:09:39 INFO - 2015-11-23 11:09:39,264 DEBUG : BROWSER_OUTPUT: __end_cc_report 11:09:39 INFO - 2015-11-23 11:09:39,264 DEBUG : BROWSER_OUTPUT: __startTimestamp1448305779259__endTimestamp 11:09:39 INFO - 2015-11-23 11:09:39,264 DEBUG : BROWSER_OUTPUT: 11:09:39 INFO - 2015-11-23 11:09:39,268 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 11:09:39 INFO - 2015-11-23 11:09:39,268 DEBUG : BROWSER_OUTPUT: Number of tests: 14 11:09:39 INFO - 2015-11-23 11:09:39,268 DEBUG : BROWSER_OUTPUT: 11:09:39 INFO - 2015-11-23 11:09:39,268 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:106.50 Median:109.00 stddev:4.77 (4.4%) stddev-sans-first:5.02 11:09:39 INFO - 2015-11-23 11:09:39,268 DEBUG : BROWSER_OUTPUT: Values: 108.0 109.0 103.0 109.0 109.0 110.0 100.0 111.0 109.0 97.0 11:09:39 INFO - 2015-11-23 11:09:39,269 DEBUG : BROWSER_OUTPUT: 11:09:39 INFO - 2015-11-23 11:09:39,269 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:141.90 Median:150.50 stddev:14.80 (9.8%) stddev-sans-first:15.14 11:09:39 INFO - 2015-11-23 11:09:39,269 DEBUG : BROWSER_OUTPUT: Values: 153.0 123.0 150.0 159.0 124.0 151.0 147.0 133.0 157.0 122.0 11:09:39 INFO - 2015-11-23 11:09:39,269 DEBUG : BROWSER_OUTPUT: 11:09:39 INFO - 2015-11-23 11:09:39,269 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:161.60 Median:161.50 stddev:2.67 (1.7%) stddev-sans-first:2.83 11:09:39 INFO - 2015-11-23 11:09:39,269 DEBUG : BROWSER_OUTPUT: Values: 161.0 167.0 160.0 159.0 162.0 161.0 158.0 162.0 165.0 161.0 11:09:39 INFO - 2015-11-23 11:09:39,269 DEBUG : BROWSER_OUTPUT: 11:09:39 INFO - 2015-11-23 11:09:39,270 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:81.50 Median:72.50 stddev:13.85 (19.1%) stddev-sans-first:14.26 11:09:39 INFO - 2015-11-23 11:09:39,270 DEBUG : BROWSER_OUTPUT: Values: 72.0 71.0 85.0 98.0 73.0 71.0 72.0 108.0 94.0 71.0 11:09:39 INFO - 2015-11-23 11:09:39,270 DEBUG : BROWSER_OUTPUT: 11:09:39 INFO - 2015-11-23 11:09:39,270 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:105.10 Median:92.00 stddev:20.43 (22.2%) stddev-sans-first:21.11 11:09:39 INFO - 2015-11-23 11:09:39,270 DEBUG : BROWSER_OUTPUT: Values: 92.0 92.0 133.0 92.0 93.0 92.0 137.0 93.0 93.0 134.0 11:09:39 INFO - 2015-11-23 11:09:39,270 DEBUG : BROWSER_OUTPUT: 11:09:39 INFO - 2015-11-23 11:09:39,270 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:109.40 Median:109.50 stddev:0.52 (0.5%) stddev-sans-first:0.50 11:09:39 INFO - 2015-11-23 11:09:39,270 DEBUG : BROWSER_OUTPUT: Values: 110.0 110.0 109.0 109.0 109.0 109.0 110.0 109.0 110.0 109.0 11:09:39 INFO - 2015-11-23 11:09:39,270 DEBUG : BROWSER_OUTPUT: 11:09:39 INFO - 2015-11-23 11:09:39,270 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:146.00 Median:146.00 stddev:0.67 (0.5%) stddev-sans-first:0.60 11:09:39 INFO - 2015-11-23 11:09:39,271 DEBUG : BROWSER_OUTPUT: Values: 145.0 147.0 146.0 146.0 146.0 145.0 147.0 146.0 146.0 146.0 11:09:39 INFO - 2015-11-23 11:09:39,271 DEBUG : BROWSER_OUTPUT: 11:09:39 INFO - 2015-11-23 11:09:39,271 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:96.00 Median:96.00 stddev:0.47 (0.5%) stddev-sans-first:0.50 11:09:39 INFO - 2015-11-23 11:09:39,271 DEBUG : BROWSER_OUTPUT: Values: 96.0 96.0 96.0 96.0 96.0 97.0 96.0 95.0 96.0 96.0 11:09:39 INFO - 2015-11-23 11:09:39,271 DEBUG : BROWSER_OUTPUT: 11:09:39 INFO - 2015-11-23 11:09:39,271 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:56.60 Median:57.00 stddev:1.35 (2.4%) stddev-sans-first:1.42 11:09:39 INFO - 2015-11-23 11:09:39,271 DEBUG : BROWSER_OUTPUT: Values: 57.0 59.0 56.0 56.0 56.0 57.0 57.0 58.0 56.0 54.0 11:09:39 INFO - 2015-11-23 11:09:39,271 DEBUG : BROWSER_OUTPUT: 11:09:39 INFO - 2015-11-23 11:09:39,271 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:68.60 Median:69.00 stddev:0.52 (0.7%) stddev-sans-first:0.50 11:09:39 INFO - 2015-11-23 11:09:39,271 DEBUG : BROWSER_OUTPUT: Values: 68.0 68.0 68.0 68.0 69.0 69.0 69.0 69.0 69.0 69.0 11:09:39 INFO - 2015-11-23 11:09:39,271 DEBUG : BROWSER_OUTPUT: 11:09:39 INFO - 2015-11-23 11:09:39,271 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:83.90 Median:84.00 stddev:0.57 (0.7%) stddev-sans-first:0.60 11:09:39 INFO - 2015-11-23 11:09:39,271 DEBUG : BROWSER_OUTPUT: Values: 84.0 85.0 84.0 84.0 83.0 84.0 84.0 83.0 84.0 84.0 11:09:39 INFO - 2015-11-23 11:09:39,272 DEBUG : BROWSER_OUTPUT: 11:09:39 INFO - 2015-11-23 11:09:39,272 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:119.70 Median:120.00 stddev:2.98 (2.5%) stddev-sans-first:3.15 11:09:39 INFO - 2015-11-23 11:09:39,272 DEBUG : BROWSER_OUTPUT: Values: 119.0 120.0 127.0 118.0 121.0 116.0 120.0 119.0 117.0 120.0 11:09:39 INFO - 2015-11-23 11:09:39,272 DEBUG : BROWSER_OUTPUT: 11:09:39 INFO - 2015-11-23 11:09:39,272 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:146.90 Median:148.50 stddev:4.89 (3.3%) stddev-sans-first:4.27 11:09:39 INFO - 2015-11-23 11:09:39,272 DEBUG : BROWSER_OUTPUT: Values: 139.0 150.0 154.0 148.0 149.0 149.0 148.0 148.0 146.0 138.0 11:09:39 INFO - 2015-11-23 11:09:39,272 DEBUG : BROWSER_OUTPUT: 11:09:39 INFO - 2015-11-23 11:09:39,272 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.10 Median:68.00 stddev:1.52 (2.2%) stddev-sans-first:1.41 11:09:39 INFO - 2015-11-23 11:09:39,272 DEBUG : BROWSER_OUTPUT: Values: 65.0 69.0 68.0 66.0 67.0 65.0 66.0 68.0 69.0 68.0 11:09:39 INFO - 2015-11-23 11:09:39,272 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 11:09:39 INFO - 2015-11-23 11:09:39,272 DEBUG : BROWSER_OUTPUT: 11:09:40 INFO - 2015-11-23 11:09:40,130 INFO : Browser exited with error code: 0 11:09:40 INFO - 2015-11-23 11:09:40,184 INFO : Completed test kraken (00:00:58) 11:09:40 INFO - 2015-11-23 11:09:40,184 INFO : Starting test v8_7 11:09:40 INFO - 2015-11-23 11:09:40,184 DEBUG : operating with platform_type : linux_ 11:09:40 INFO - 2015-11-23 11:09:40,184 INFO : Initialising browser for v8_7 test... 11:09:40 INFO - 2015-11-23 11:09:40,190 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp6iycIA/profile http://localhost:39633/getInfo.html 11:09:43 INFO - 2015-11-23 11:09:43,830 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 11:09:43 INFO - 2015-11-23 11:09:43,831 DEBUG : BROWSER_OUTPUT: colorDepth:24 11:09:43 INFO - 2015-11-23 11:09:43,831 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 11:09:43 INFO - 2015-11-23 11:09:43,831 DEBUG : BROWSER_OUTPUT: __metrics 11:09:43 INFO - 2015-11-23 11:09:43,987 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 11:09:45 INFO - 2015-11-23 11:09:45,160 INFO : Browser initialized. 11:09:45 INFO - 2015-11-23 11:09:45,161 INFO : Running cycle 1/1 for v8_7 test... 11:09:45 INFO - 2015-11-23 11:09:45,161 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp6iycIA/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 11:09:56 INFO - 2015-11-23 11:09:56,942 DEBUG : BROWSER_OUTPUT: RSS: Main: 141996032 11:09:56 INFO - 2015-11-23 11:09:56,942 DEBUG : BROWSER_OUTPUT: 11:10:18 INFO - 2015-11-23 11:10:18,376 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39633/tests/v8_7/run.html (next: http://localhost:39633/tests/v8_7/run.html) 11:10:18 INFO - 2015-11-23 11:10:18,627 DEBUG : BROWSER_OUTPUT: RSS: Main: 620826624 11:10:18 INFO - 2015-11-23 11:10:18,627 DEBUG : BROWSER_OUTPUT: 11:10:18 INFO - 2015-11-23 11:10:18,627 DEBUG : BROWSER_OUTPUT: __start_tp_report 11:10:18 INFO - 2015-11-23 11:10:18,627 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 11:10:18 INFO - 2015-11-23 11:10:18,628 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 11:10:18 INFO - 2015-11-23 11:10:18,628 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 11:10:18 INFO - 2015-11-23 11:10:18,628 DEBUG : BROWSER_OUTPUT: |0;Richards;190.11406844106463 11:10:18 INFO - 2015-11-23 11:10:18,628 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;194.51468585878234 11:10:18 INFO - 2015-11-23 11:10:18,628 DEBUG : BROWSER_OUTPUT: |2;Encrypt;284.2524161455372 11:10:18 INFO - 2015-11-23 11:10:18,628 DEBUG : BROWSER_OUTPUT: |3;Decrypt;4995.024875621891 11:10:18 INFO - 2015-11-23 11:10:18,629 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1988.0715705765408 11:10:18 INFO - 2015-11-23 11:10:18,629 DEBUG : BROWSER_OUTPUT: |5;Earley;786.1635220125786 11:10:18 INFO - 2015-11-23 11:10:18,629 DEBUG : BROWSER_OUTPUT: |6;Boyer;12000 11:10:18 INFO - 2015-11-23 11:10:18,629 DEBUG : BROWSER_OUTPUT: |7;RegExp;27805.555555555555 11:10:18 INFO - 2015-11-23 11:10:18,629 DEBUG : BROWSER_OUTPUT: |8;Splay;644.9136276391555 11:10:18 INFO - 2015-11-23 11:10:18,629 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4830.917874396136 11:10:18 INFO - 2015-11-23 11:10:18,629 DEBUG : BROWSER_OUTPUT: __end_tp_report 11:10:18 INFO - 2015-11-23 11:10:18,630 DEBUG : BROWSER_OUTPUT: __startTimestamp1448305818624__endTimestamp 11:10:18 INFO - 2015-11-23 11:10:18,630 DEBUG : BROWSER_OUTPUT: 11:10:18 INFO - 2015-11-23 11:10:18,630 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 11:10:18 INFO - 2015-11-23 11:10:18,630 DEBUG : BROWSER_OUTPUT: Number of tests: 10 11:10:18 INFO - 2015-11-23 11:10:18,630 DEBUG : BROWSER_OUTPUT: 11:10:18 INFO - 2015-11-23 11:10:18,630 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:190.11 Median:190.11 stddev:0.00 (0.0%) 11:10:18 INFO - 2015-11-23 11:10:18,630 DEBUG : BROWSER_OUTPUT: Values: 190.1 11:10:18 INFO - 2015-11-23 11:10:18,630 DEBUG : BROWSER_OUTPUT: 11:10:18 INFO - 2015-11-23 11:10:18,630 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:194.51 Median:194.51 stddev:0.00 (0.0%) 11:10:18 INFO - 2015-11-23 11:10:18,630 DEBUG : BROWSER_OUTPUT: Values: 194.5 11:10:18 INFO - 2015-11-23 11:10:18,630 DEBUG : BROWSER_OUTPUT: 11:10:18 INFO - 2015-11-23 11:10:18,630 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:284.25 Median:284.25 stddev:0.00 (0.0%) 11:10:18 INFO - 2015-11-23 11:10:18,631 DEBUG : BROWSER_OUTPUT: Values: 284.3 11:10:18 INFO - 2015-11-23 11:10:18,631 DEBUG : BROWSER_OUTPUT: 11:10:18 INFO - 2015-11-23 11:10:18,631 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:4995.02 Median:4995.02 stddev:0.00 (0.0%) 11:10:18 INFO - 2015-11-23 11:10:18,631 DEBUG : BROWSER_OUTPUT: Values: 4995.0 11:10:18 INFO - 2015-11-23 11:10:18,631 DEBUG : BROWSER_OUTPUT: 11:10:18 INFO - 2015-11-23 11:10:18,631 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1988.07 Median:1988.07 stddev:0.00 (0.0%) 11:10:18 INFO - 2015-11-23 11:10:18,631 DEBUG : BROWSER_OUTPUT: Values: 1988.1 11:10:18 INFO - 2015-11-23 11:10:18,631 DEBUG : BROWSER_OUTPUT: 11:10:18 INFO - 2015-11-23 11:10:18,631 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:786.16 Median:786.16 stddev:0.00 (0.0%) 11:10:18 INFO - 2015-11-23 11:10:18,632 DEBUG : BROWSER_OUTPUT: Values: 786.2 11:10:18 INFO - 2015-11-23 11:10:18,632 DEBUG : BROWSER_OUTPUT: 11:10:18 INFO - 2015-11-23 11:10:18,632 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:12000.00 Median:12000.00 stddev:0.00 (0.0%) 11:10:18 INFO - 2015-11-23 11:10:18,632 DEBUG : BROWSER_OUTPUT: Values: 12000.0 11:10:18 INFO - 2015-11-23 11:10:18,632 DEBUG : BROWSER_OUTPUT: 11:10:18 INFO - 2015-11-23 11:10:18,632 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:27805.56 Median:27805.56 stddev:0.00 (0.0%) 11:10:18 INFO - 2015-11-23 11:10:18,632 DEBUG : BROWSER_OUTPUT: Values: 27805.6 11:10:18 INFO - 2015-11-23 11:10:18,632 DEBUG : BROWSER_OUTPUT: 11:10:18 INFO - 2015-11-23 11:10:18,632 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:644.91 Median:644.91 stddev:0.00 (0.0%) 11:10:18 INFO - 2015-11-23 11:10:18,632 DEBUG : BROWSER_OUTPUT: Values: 644.9 11:10:18 INFO - 2015-11-23 11:10:18,632 DEBUG : BROWSER_OUTPUT: 11:10:18 INFO - 2015-11-23 11:10:18,632 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4830.92 Median:4830.92 stddev:0.00 (0.0%) 11:10:18 INFO - 2015-11-23 11:10:18,632 DEBUG : BROWSER_OUTPUT: Values: 4830.9 11:10:18 INFO - 2015-11-23 11:10:18,632 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 11:10:18 INFO - 2015-11-23 11:10:18,632 DEBUG : BROWSER_OUTPUT: 11:10:19 INFO - 2015-11-23 11:10:19,526 INFO : Browser exited with error code: 0 11:10:19 INFO - 2015-11-23 11:10:19,545 INFO : Completed test v8_7 (00:00:39) 11:10:19 INFO - 2015-11-23 11:10:19,606 INFO : Completed test suite (00:20:11) 11:10:19 INFO - 2015-11-23 11:10:19,606 DEBUG : Working with test: dromaeo_css 11:10:19 INFO - 2015-11-23 11:10:19,606 DEBUG : Generating results file: dromaeo_css 11:10:19 INFO - 2015-11-23 11:10:19,607 DEBUG : Working with test: kraken 11:10:19 INFO - 2015-11-23 11:10:19,608 DEBUG : Generating results file: kraken 11:10:19 INFO - 2015-11-23 11:10:19,608 INFO : javascript benchmark 11:10:19 INFO - 2015-11-23 11:10:19,608 DEBUG : Working with test: v8_7 11:10:19 INFO - 2015-11-23 11:10:19,608 DEBUG : Generating results file: v8_7 11:10:19 INFO - 2015-11-23 11:10:19,609 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 11:10:19 INFO - 2015-11-23 11:10:19,666 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,64,35]] 11:10:19 INFO - 2015-11-23 11:10:19,666 DEBUG : process_Request line: dromaeo_css 6870.31 graph.html#tests=[[72,64,35]] 11:10:19 INFO - 2015-11-23 11:10:19,666 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 11:10:19 INFO - 2015-11-23 11:10:19,699 DEBUG : process_Request line: kraken 1490.80 graph.html#tests=[[232,64,35]] 11:10:19 INFO - 2015-11-23 11:10:19,699 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 11:10:19 INFO - 2015-11-23 11:10:19,726 DEBUG : process_Request line: v8_7 19334.68 graph.html#tests=[[230,64,35]] 11:10:19 INFO - 2015-11-23 11:10:19,728 INFO : javascript benchmark 11:10:19 INFO - 2015-11-23 11:10:19,731 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3185.155933677575, 3242.140832679339, 3287.638359780424, 3294.159989202753, 3304.884329048484, 5292.126799078157, 5383.0, 5476.890462190754, 5479.260299859523, 5504.201890725847, 5441.374241962176, 5448.264484294619, 5472.480114389136, 5536.2249285100015, 5584.357798853133, 5004.349434573501, 5084.262781896641, 5107.259447380127, 5151.665141765792, 5184.507471790174, 4963.478834722357, 4968.478309777475, 5018.64869459138, 5068.34111565496, 5099.490150177539, 4922.630802689777, 5017.523335283142, 5031.044101620717, 5056.191009438472, 5082.542571168594, 4899.828506002273, 4971.527704868032, 5022.27177059328, 5036.597072234213, 5061.873453163664, 5010.5240002199735, 5012.398512178562, 5021.372328458942, 5039.798408063673, 5057.69653820772, 5145.15105007677, 5214.556762675177, 5244.5017723316605, 5296.09966305729, 5326.6803991760235, 5657.8019769307875, 5793.594448388614, 5796.797112101056, 5796.88406231873, 5844.88310233793, 6067.423594758491, 6071.787487437962, 6081.665508397036, 6082.239720034996, 6093.421124993119, 5388.245645609618, 5471.50756431923, 5483.341998960151, 5632.662040277596, 5634.661920284796, 5930.762769489172, 6043.576949613484, 6048.183495228088, 6051.546134039877, 6077.787277445268, 5881.441263080001, 5881.794137205263, 5887.852803679943, 5888.499477544457, 5892.970535147382, 5634.6337488063145, 5835.387284335168, 5953.613015154087, 5965.522758179335, 5998.910016349758, 5774.335951365562, 5810.564207684441, 5851.268591426072, 5876.471117599436, 5903.645781253139, 5845.912311315334, 5852.561057920673, 5853.268341457318, 5880.500157486662, 5930.525557955353, 4423.601875831127, 4514.187446259705, 4544.341070544752, 4550.089982003613, 4576.496585375606, 3974.046228905042, 4036.4752582164133, 4039.4546736190237, 4070.4504891839815, 4092.2224777292217, 5632.915506267409, 5660.377358490563, 5664.943350566524, 5668.9716551417805, 5672.4894759471845, 5607.551395888319, 5692.117721753135, 5700.40145784695, 5954.434328738763, 5970.0746384310505, 5533.612647114664, 5635.746391412396, 5638.464345887134, 5641.984442800253, 5677.51741102011, 5138.434772175057, 5169.638125331191, 5207.21891716238, 5213.556847667915, 5233.188855727369, 6234.625922444668, 6266.404691554295, 6270.090836828543, 6277.278113016971, 6278.968605156945, 5675.432456754292, 5732.140178973021, 5734.827955161351, 5776.537876969748, 5984.222051133324, 6155.138280640804, 6157.507399407947, 6159.414855588712, 6162.599431037148, 6167.722452489559, 5821.155932389865, 5868.706564671835, 5871.823845284648, 5884.08796636522, 5963.403659634002, 5644.8306550803545, 5829.09649004405, 5833.183354330482, 5839.211706419579, 5849.970750146222, 5669.688167150846, 5670.914936275876, 5672.177534257592, 5676.460736230051, 5705.800296989585, 5799.884002320015, 5812.21535092774, 5825.76696932118, 5833.533317334518, 5835.649861008353, 5650.321961364498, 5692.743826527733, 5697.686627235542, 5698.54411647059, 5723.313202415737, 5592.245046918777, 5661.603687741818, 5800.361960184292, 5814.447627475383, 5852.122181672783, 5602.52378547828, 5651.124075768263, 5656.462636049569, 5670.291213598301, 5712.714639206145], "unit": "ms", "name": "dojo.html", "value": 5438.764075496377}, {"lowerIsBetter": false, "replicates": [550.9283793106896, 589.119266696289, 606.78155863889, 607.3865395950089, 632.4908448698795, 31565.21086972824, 40652.0, 40966.38550421739, 41045.58954410455, 41125.7943710281, 44325.77837110818, 44955.77522112393, 44957.0, 45028.0, 45113.77443112788, 7570.167281599047, 7752.689892404325, 8741.912580874174, 8937.195652391283, 10204.94897525515, 10345.793084138313, 10462.110720588758, 10464.05823475887, 10464.267501274913, 10475.528601212964, 10456.424896630682, 10489.0, 10536.736581585445, 10561.471926403687, 10563.947180264087, 7813.687452501893, 7975.0, 10539.104176145036, 10760.623378181726, 10780.137588992862, 10274.640387586473, 10332.0, 10382.79234415315, 10390.636327728569, 10398.0, 40471.7976410119, 40983.59016409828, 40998.0, 41018.179636407105, 41026.0, 3208.470602350609, 3241.4327492688685, 3548.7515873888838, 3910.237503686782, 3967.504061992251, 31038.224044398845, 31474.37051258962, 31585.503794465854, 32510.024699259062, 32949.341013179845, 3842.154725960312, 3856.8842934712, 3888.241792850395, 3955.5253369595544, 3989.2819292527333, 269352.0, 272543.0, 273249.0, 273530.999999998, 275152.0, 57878.7106064467, 58531.41468585259, 60610.18169454923, 60700.69649651724, 61198.38801611927, 69936.65031674808, 70664.6466767663, 71110.0, 71120.2887971124, 71141.0, 14912.552623421314, 15083.54749357521, 15091.24543772807, 15095.4716584919, 15126.39494420233, 10777.676669699922, 10875.347479151276, 10886.129109671207, 10895.509702063426, 10919.39943303126, 20021.899890500747, 20159.697604535944, 20178.495537611383, 20231.0, 20279.29022484206, 7471.925280747231, 7583.886241706379, 7686.500377475558, 7782.377409807202, 7837.882431763528, 825.5418242875141, 930.6742640076054, 942.5758408716105, 954.5322791832091, 1002.8997100289913, 28560.285992850346, 28587.857060714563, 28968.0, 29288.414231715247, 29314.413711725647, 991.2714155095998, 998.9750256243652, 1063.3194755356578, 1118.8825173356843, 1158.9826152607718, 13851.238181900093, 14139.928654471085, 14267.78598321026, 14291.713745762723, 14319.642008949859, 315618.0, 319573.0, 319746.0, 319869.0, 321424.0, 51933.22100168501, 52203.47796522062, 52231.47768522342, 52237.21644175341, 52266.738666306424, 1208.4018410886492, 1225.2587184753274, 1329.7008173160962, 1341.1215653746617, 1408.556304763996, 27305.590416143375, 28658.57012144861, 28817.279568010967, 29117.85441072781, 29360.0, 43893.0, 44199.558004419545, 44317.44888928872, 44328.335074973256, 44953.32570011387, 381706.0, 388911.0, 389094.0, 389230.0, 389725.0, 30122.24694382658, 30760.0, 30764.384712306077, 30790.692093078782, 30859.0, 42120.36819447772, 42549.78725106355, 42642.57357426386, 43439.34840977451, 43568.12863742771, 36605.81697091497, 36932.630673693995, 37128.81435592805, 37300.6269937308, 37645.81177094097, 35409.29181416409, 36486.27027459489, 36581.45127823031, 36833.26333473369, 37177.0, 33473.66526334705, 33649.15877103092, 33673.0, 33678.326433470706, 35807.641923581476, 30224.0, 30340.24149396283, 30809.8459507701, 30870.0, 31032.22419439532, 22278.88860555687, 22566.323010309716, 25332.0, 25438.618420724073, 26755.464890702468], "unit": "ms", "name": "ext.html", "value": 18981.099367161438}, {"lowerIsBetter": false, "replicates": [359.7535688053683, 363.61820088906643, 364.30236097872574, 364.5934782717271, 365.34785408046645, 14397.928010359934, 14458.349374278156, 16608.418705345317, 16824.74762878558, 17525.824741752578, 10389.740256493591, 10644.0, 16467.423640172598, 16944.576385590368, 17005.65988680229, 4795.760211989404, 4903.779329930144, 4905.0, 4906.411230652327, 4909.459959404463, 3745.1386181178345, 3840.1935593525395, 4865.197242455009, 4866.7566621668775, 5886.705664716768, 5905.232319798421, 5917.55618328627, 5946.137810017545, 5964.88070238595, 5973.790917317895, 5349.679019258818, 5354.678719276856, 5366.221897824794, 5411.83764487066, 5920.644761314314, 5158.793648254103, 5162.74186290684, 5180.8963820723375, 5184.0, 5188.481151884819, 12139.575114870937, 12761.361931903368, 12849.843514083685, 12851.678708032374, 12858.0, 1925.1144473542188, 1952.7363805886307, 1964.0474369930573, 1977.74289342386, 2089.8328133749264, 9272.119148680864, 9474.763130921781, 9580.377275477142, 12536.0, 13071.542496012595, 1818.5271829324338, 1825.4979880532826, 1868.6169335286233, 1879.7274395212617, 1882.2847318019064, 59244.40755592432, 60678.999999999556, 60965.695171524305, 61464.999999999556, 62044.68977655128, 9525.618975241052, 9555.474448905377, 9623.182029527568, 9717.59094931245, 9877.456739879231, 12226.816597751042, 12262.0, 12281.140320177681, 12296.20074695142, 12313.753724925451, 7026.297370263035, 7286.0, 7297.562146271241, 7465.477416580896, 7624.466287359832, 6859.622720750307, 6871.0, 6898.896516552155, 6908.585484870924, 6916.20463646677, 4018.176273863851, 4058.0463591056077, 4070.653994410449, 4206.831726730958, 4323.308270676676, 1690.797104347486, 1713.2461716844548, 1744.2499725118066, 1757.789065312145, 1784.732290156461, 404.1512823071585, 409.09181616810633, 953.3469573342283, 1034.534459493216, 1048.5229220704562, 8806.339524535686, 9992.650257241106, 10696.090832279344, 10889.074428673652, 11023.283486573348, 420.11356038758197, 428.5992596921888, 431.6503632058043, 442.0716495359783, 455.0466772112419, 5649.858753531194, 5779.162021506858, 5858.209141765892, 5884.176215329857, 5895.823125306248, 514359.77604522987, 526386.0, 529394.0, 536326.0, 536625.0, 78897.0, 79139.20860791318, 80979.59510202412, 81330.0, 82926.17073829305, 482.1369748150771, 486.7104073076514, 487.1863987141482, 487.6513292995525, 488.7776061891831, 10081.344712593658, 10114.747131321776, 10168.853676652638, 10181.185505159718, 10183.0, 32350.19124521906, 32621.347573047933, 33020.1744956378, 33791.324173516885, 33907.0, 45287.77356113198, 46284.53715462937, 46460.30309545427, 46951.0, 47648.523514765795, 8803.823923521366, 9037.77405564866, 9117.863232051392, 9280.814383712423, 9311.0, 10704.571817127227, 11914.702132446411, 17512.474625761246, 17785.28858845632, 17969.73045404346, 14108.153510788974, 14185.432582696576, 14301.427942882168, 14607.92696036513, 15002.924985375003, 14015.50945716895, 14061.578152655436, 14381.568552943429, 14426.639334016734, 14529.288337993403, 11473.942630286796, 11867.762644746885, 13157.276349800853, 14091.295435228403, 14584.927075364556, 8635.179657932485, 8648.1784230498, 9014.2788576915, 9407.764805879908, 9423.81152376935, 9517.571709273238, 14212.644683882985, 14234.074785138933, 14325.426982920982, 14531.200783956561], "unit": "ms", "name": "jquery.html", "value": 7787.352625090552}, {"lowerIsBetter": false, "replicates": [1324.4834514539325, 1718.3556166437584, 1742.3901634427953, 1766.3376233912284, 1774.3878361965126, 6495.058216558602, 7515.924840751591, 7683.270089341518, 7690.115636701788, 7701.306882380599, 7423.1092268927805, 7554.773356799291, 7555.735549255777, 7559.69761209551, 7562.281583249596, 1954.1694779718634, 1986.016921623791, 2239.2274665240466, 2243.6858839762444, 2262.7850354216407, 2281.6805647209403, 2286.0969916882823, 2286.1541229744935, 2286.3369622809364, 2287.565362581104, 2209.0501084533644, 2261.2650888461317, 2267.886605669718, 2271.3980795089315, 2285.531466049464, 1873.9812601874012, 1929.4790406590212, 2197.8351623628214, 2232.096001119533, 2243.2933625907785, 2284.280451657739, 2292.9197478088186, 2319.373769082338, 2319.9652005219937, 2321.9651705224437, 7660.348870346027, 7733.7679869604, 7734.110577283572, 7734.110577283628, 7750.341220996222, 4572.359869618256, 4660.231061874787, 4676.766161691936, 4679.040796636681, 4680.3447517347595, 2964.318206812445, 3021.5165573508352, 3054.923626909345, 3063.754899608048, 3076.461619216628, 914.0813482450161, 920.8664743612205, 925.3892430995578, 937.5031233446284, 939.0, 10598.682039538826, 10608.15134789215, 10611.416372099531, 10615.363078215254, 10620.203484738675, 4117.641178411117, 4148.979255103705, 4196.790160491963, 4284.378765079046, 4293.3989241506215, 8938.46369217849, 8991.685291014914, 9040.095990400907, 9049.140331668481, 9062.275017998545, 4626.930596041062, 4653.2554791233915, 4694.976525117421, 4696.03731235096, 4701.95298047022, 4240.851570195028, 4246.256905041667, 4247.129338485664, 4248.681348898845, 4250.829966801355, 3673.3571624966057, 3725.4970578972034, 3730.9440358394645, 3745.8127093645207, 3758.0604848787802, 1240.1938739819009, 1244.2658831289582, 1249.5064449542563, 1252.8183413405188, 1254.799232122856, 1229.8339724137306, 1243.8569564500199, 1257.798752199662, 1269.6698858296909, 1270.7140893298933, 6467.0, 6714.3957043866285, 7234.385077268385, 7352.154502232205, 7405.1854296027395, 567.6367125039977, 568.7668056097064, 573.383612616439, 597.554821657859, 601.5458328961694, 5685.232493613309, 5688.800891968761, 5693.430656934356, 5733.197352370671, 5736.4550367715, 8987.775305617412, 9057.09429057089, 9264.166225039779, 9275.0261222572, 9315.48764817928, 8981.775455613662, 9000.819983600291, 9126.771830704152, 9163.954180229057, 9166.037566055467, 7000.544964577286, 7165.462590305748, 7175.928240717526, 7269.164046134762, 7270.091238595176, 6936.890097584363, 6940.09778728762, 6982.301769822977, 6985.301469853177, 6987.266337034538, 7937.563434011185, 8127.837443250984, 8201.42590018693, 8233.629486673233, 8293.377996650155, 8300.252977232078, 8447.113053129333, 8451.577421129043, 8464.195901389357, 8472.19514146155, 6738.696758645775, 6829.521933464808, 6853.040574319699, 6854.383105520327, 6866.313368663094, 7249.0, 7274.236205198378, 7294.854102918018, 7303.050603421521, 7306.0, 6700.329967003456, 6819.249882513019, 6826.351496607815, 6943.236244013256, 6980.406665433495, 6720.731170753115, 6764.864702706017, 6796.048553202654, 6805.04729337903, 6852.383285504328, 6191.752329906753, 6293.213348331458, 6350.7777227796805, 6431.935680643321, 6614.867702645824, 5979.5814292999075, 6219.968900155471, 6268.404501572343, 6276.466500347339, 6297.779577714941, 6288.654124023223, 6327.905081423874, 6333.20834895638, 6337.081123237197, 6338.144350512622], "unit": "ms", "name": "mootools.html", "value": 4342.892239622426}, {"lowerIsBetter": false, "replicates": [333.41319278070597, 334.9045522026223, 338.7290167865707, 338.90171850163455, 342.1787709497208, 6103.603265787732, 6104.6947652617355, 6110.602810817294, 6176.382361763822, 6188.752449902004, 6036.154938308629, 6069.484093852028, 6070.969645151768, 6075.2405949256345, 6100.481459075984, 4676.205045142334, 4697.553732395434, 4701.976490117545, 4707.0, 4707.082118986799, 4467.262901621229, 4596.54034596541, 4606.677532572721, 4613.953860461403, 4618.630509559227, 4534.79593418297, 4539.024109816389, 4551.112533056039, 4554.0664163846495, 4554.134714404253, 4416.470023597157, 4472.016156445577, 4489.169503641837, 4549.24937385331, 4549.931751023721, 3958.762474251554, 3965.8215380307665, 3976.224636195943, 3986.362182050887, 3991.2815693175216, 5698.857528561778, 5703.287089113861, 5711.086226203787, 5731.083026715705, 5738.139279108167, 5030.0, 5120.718360490171, 5160.974195129038, 5211.166213405837, 5352.625316227865, 6380.7128679209545, 6382.968085159591, 6387.776427825051, 6398.360163983564, 6401.679916004181, 4396.494403143647, 4403.185410699031, 4407.0, 4409.184300904343, 4409.536998615164, 6531.216254049497, 6623.172103487064, 6690.899636505407, 6691.230508491537, 6701.396874281338, 4475.30632751924, 4512.052468981485, 4516.841910533116, 4517.954820451753, 4518.638508919278, 4524.434445694288, 4530.728156310632, 4532.297493888453, 4561.315802629632, 4574.931376029363, 5267.2889159962915, 5305.389880163753, 5316.7075810830775, 5318.547923426475, 5330.440303768049, 6274.247090349188, 6426.678666066771, 6446.9040263155375, 6478.352164783578, 6479.6760161991715, 1594.0913679202743, 1601.7597360396035, 1603.7033148867497, 1605.389951818325, 1605.8073031236092, 1050.2543194332109, 1056.2817284246632, 1061.2836335473523, 1061.6974162363845, 1079.956801727922, 6293.370662933761, 6295.276043255084, 6301.7164227609865, 6306.400891915261, 6308.589941653778, 6686.96656516724, 6687.665616719145, 6687.899681504781, 6693.263740988487, 6700.631465269457, 6163.722632481549, 6308.968455157695, 6321.462675672619, 6321.589096708699, 6326.588771729823, 3615.096225943514, 3635.4365073413665, 3635.6727894489622, 3642.5446819147605, 3644.325799727006, 6952.652367381611, 6973.232944376115, 6982.720691172296, 6986.196587392515, 6992.2658120897595, 6543.247526534509, 6654.201495820435, 6772.55978361405, 6805.557638753465, 6808.489363297773, 6771.627560484122, 6948.861022779617, 6954.4436445084275, 6960.721571137199, 6968.790936271818, 6560.245571759308, 6644.734210631714, 6649.73401063952, 6708.765193218214, 6729.730810767514, 6520.836979075561, 6669.866602667822, 6672.266050734318, 6681.365270299314, 6683.097781799589, 7040.823979400556, 7053.435725142079, 7054.153501579844, 7058.5764854106865, 7059.364657180879, 4512.097580483982, 4515.34527493505, 4519.683622146418, 4523.705959112647, 4529.977350113229, 6714.0, 6716.227633821977, 6717.529772916045, 6724.092247546519, 6727.596344219362, 6375.74497020114, 6601.075849380994, 6601.075849381186, 6611.636360000246, 6620.3710647488415, 6562.80311590653, 6579.605223686594, 6582.243042050034, 6586.868262634624, 6597.439217666552, 6240.687965601793, 6466.708998095003, 6475.417212450902, 6478.838029049123, 6486.091947127312, 6599.53803233769, 6599.967000164968, 6601.801945941629, 6607.372299631527, 6609.10777045112, 6430.614163150226, 6435.903461447989, 6441.323661015525, 6443.96778016107, 6447.4197322241225], "unit": "ms", "name": "prototype.html", "value": 4855.8606149882}, {"lowerIsBetter": false, "replicates": [658.2232965101178, 658.5719282466396, 834.6452757578029, 840.8402403543326, 851.7479305421028, 13783.931080344597, 14079.92960035201, 14149.151050936951, 14224.288785560719, 14238.288085595705, 13106.0, 13159.605211843636, 13190.0, 13195.0, 13196.670083247924, 668.1447746883972, 676.1210426445625, 805.6495424490336, 822.7490615362312, 823.3618945317397, 804.4288555125868, 806.9031716194036, 813.276184196066, 814.4176913506841, 815.9918400816005, 845.8773477845708, 856.1566856646199, 856.3448961544424, 856.4604299291437, 856.6830272799042, 703.0824773670358, 709.0569542508451, 838.7693384319361, 847.8982522097357, 849.7918010087568, 621.3258614403333, 622.3869488553771, 624.3007831229007, 624.7407325959721, 625.3933684326196, 12906.161099528501, 13036.0, 13068.803967940488, 13078.280694561796, 13078.411471483807, 11555.76888462226, 11800.46897889597, 11863.347515886622, 12094.637160885188, 12479.376031198495, 9879.407235565817, 10069.949650251776, 10319.638812641522, 10374.948125259401, 10493.842592361121, 3528.576570811493, 3532.3818331791836, 3545.2023294758733, 3558.5551806024246, 3699.445083237509, 49878.96839232195, 50550.0, 50870.23694644583, 51555.96888062255, 51738.7413062936, 9077.77305567353, 9127.634894604142, 9146.724342426456, 9248.0, 9386.296027797942, 15778.0, 15832.050076995418, 15861.04833709958, 15866.127362994916, 15909.920450397674, 6853.760118395832, 7005.194402643761, 7105.715771369088, 7126.572405655677, 7322.816929576697, 4237.936430953539, 4238.109996900624, 4243.575642435731, 4400.075984043387, 4440.533743956838, 3162.5730526378643, 3193.1378527797365, 3195.5526226328334, 3204.07081946233, 3210.29373537826, 560.3052215253139, 570.8173384516998, 578.0635370699409, 587.3949831673383, 588.5791658963776, 578.6817250512202, 603.230880627195, 628.1237673445518, 645.3739872323838, 654.2084078265257, 8062.7422878441, 8223.794405139919, 8286.751397457965, 8398.202170793766, 8551.486910785372, 570.1704020650027, 603.8912995660735, 648.1638686094885, 655.7311502284041, 659.4131223211346, 3652.6895213907114, 3932.9213415732097, 3988.441618173458, 4002.3918676500134, 4002.6397624213378, 61809.69095154495, 61819.690901545204, 61948.38051619516, 62032.37967620266, 62122.378776212565, 53931.730341348826, 53999.19001214985, 54343.45656543463, 54501.45498545043, 55104.448955509935, 48002.759986200545, 48063.0, 48123.75938120287, 48390.75804620954, 49282.50717492779, 7763.28887119247, 7864.803379915548, 7929.960350198212, 8000.639971201426, 8057.637406316612, 34070.318593628486, 34307.82846085853, 34590.13524661803, 34741.0, 34887.476687849194, 43966.56033439752, 44309.33535997027, 45397.31904021376, 47262.76368618135, 47490.0, 9509.809803804024, 9643.228541716506, 9828.11546960777, 10180.592776288866, 10188.745281368025, 11707.356095414834, 11919.642410727693, 11920.344381059125, 12505.187162834387, 12569.371531423576, 11174.776504469703, 11438.599649012245, 11582.6525204244, 11681.0, 11959.162858599815, 11099.44502774842, 11406.714832129263, 11549.942250288696, 11802.82295765547, 11810.291382516732, 10440.56276082677, 10816.837747433638, 11128.276662016942, 11340.262882912584, 11416.0, 8915.643374264957, 9162.541872906195, 9249.676261330822, 9397.201237894855, 9454.628735300366, 8815.382923195315, 9034.774130646523, 9187.862182067409, 9258.490783006999, 9346.299027572823], "unit": "ms", "name": "yui.html", "value": 6202.471606168954}], "name": "dromaeo_css", "value": 6870.315648137217}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [108.0, 109.0, 103.0, 109.0, 109.0, 110.0, 100.0, 111.0, 109.0, 97.0], "unit": "ms", "name": "ai-astar", "value": 106.5}, {"lowerIsBetter": true, "replicates": [153.0, 123.0, 150.0, 159.0, 124.0, 151.0, 147.0, 133.0, 157.0, 122.0], "unit": "ms", "name": "audio-beat-detection", "value": 141.9}, {"lowerIsBetter": true, "replicates": [161.0, 167.0, 160.0, 159.0, 162.0, 161.0, 158.0, 162.0, 165.0, 161.0], "unit": "ms", "name": "audio-dft", "value": 161.6}, {"lowerIsBetter": true, "replicates": [72.0, 71.0, 85.0, 98.0, 73.0, 71.0, 72.0, 108.0, 94.0, 71.0], "unit": "ms", "name": "audio-fft", "value": 81.5}, {"lowerIsBetter": true, "replicates": [92.0, 92.0, 133.0, 92.0, 93.0, 92.0, 137.0, 93.0, 93.0, 134.0], "unit": "ms", "name": "audio-oscillator", "value": 105.1}, {"lowerIsBetter": true, "replicates": [110.0, 110.0, 109.0, 109.0, 109.0, 109.0, 110.0, 109.0, 110.0, 109.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 109.4}, {"lowerIsBetter": true, "replicates": [145.0, 147.0, 146.0, 146.0, 146.0, 145.0, 147.0, 146.0, 146.0, 146.0], "unit": "ms", "name": "imaging-darkroom", "value": 146.0}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 96.0, 96.0, 96.0, 97.0, 96.0, 95.0, 96.0, 96.0], "unit": "ms", "name": "imaging-desaturate", "value": 96.0}, {"lowerIsBetter": true, "replicates": [57.0, 59.0, 56.0, 56.0, 56.0, 57.0, 57.0, 58.0, 56.0, 54.0], "unit": "ms", "name": "json-parse-financial", "value": 56.6}, {"lowerIsBetter": true, "replicates": [68.0, 68.0, 68.0, 68.0, 69.0, 69.0, 69.0, 69.0, 69.0, 69.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 68.6}, {"lowerIsBetter": true, "replicates": [84.0, 85.0, 84.0, 84.0, 83.0, 84.0, 84.0, 83.0, 84.0, 84.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 83.9}, {"lowerIsBetter": true, "replicates": [119.0, 120.0, 127.0, 118.0, 121.0, 116.0, 120.0, 119.0, 117.0, 120.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 119.7}, {"lowerIsBetter": true, "replicates": [139.0, 150.0, 154.0, 148.0, 149.0, 149.0, 148.0, 148.0, 146.0, 138.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 146.9}, {"lowerIsBetter": true, "replicates": [65.0, 69.0, 68.0, 66.0, 67.0, 65.0, 66.0, 68.0, 69.0, 68.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 67.1}], "name": "kraken", "value": 1490.8000000000002}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [190.11406844106463], "unit": "score", "name": "Richards", "value": 185.68851999999995}, {"lowerIsBetter": false, "replicates": [194.51468585878234], "unit": "score", "name": "DeltaBlue", "value": 339.9126379999999}, {"lowerIsBetter": false, "replicates": [284.2524161455372], "unit": "score", "name": "Encrypt", "value": 936.4247580000001}, {"lowerIsBetter": false, "replicates": [4995.024875621891], "unit": "score", "name": "Decrypt", "value": 53.289224103585696}, {"lowerIsBetter": false, "replicates": [1988.0715705765408], "unit": "score", "name": "RayTrace", "value": 372.21446699999984}, {"lowerIsBetter": false, "replicates": [786.1635220125786], "unit": "score", "name": "Earley", "value": 847.7409359999999}, {"lowerIsBetter": false, "replicates": [12000.0], "unit": "score", "name": "Boyer", "value": 55.53858333333334}, {"lowerIsBetter": false, "replicates": [27805.555555555555], "unit": "score", "name": "RegExp", "value": 32.762697302697305}, {"lowerIsBetter": false, "replicates": [644.9136276391555], "unit": "score", "name": "Splay", "value": 126.35955654761905}, {"lowerIsBetter": false, "replicates": [4830.917874396136], "unit": "score", "name": "NavierStokes", "value": 307.1879999999999}], "name": "v8_7", "value": 19334.67895235178}]} 11:10:19 INFO - RETURN: dromaeo_css: 6870.31 11:10:19 INFO - RETURN: kraken: 1490.80 11:10:19 INFO - RETURN: v8_7: 19334.68 11:10:19 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,64,35]]", "result": "19334.68"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,35]]", "result": "1490.80"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,35]]", "result": "6870.31"}}} 11:10:19 INFO - Return code: 0 11:10:19 INFO - # TBPL SUCCESS # 11:10:19 INFO - Running post-action listener: _resource_record_post_action 11:10:19 INFO - Running post-run listener: _resource_record_post_run 11:10:20 INFO - Total resource usage - Wall time: 1227s; CPU: 13.0%; Read bytes: 20480; Write bytes: 509911040; Read time: 64; Write time: 627940 11:10:20 INFO - install - Wall time: 16s; CPU: 15.0%; Read bytes: 0; Write bytes: 218882048; Read time: 0; Write time: 316600 11:10:20 INFO - run-tests - Wall time: 1212s; CPU: 13.0%; Read bytes: 20480; Write bytes: 267513856; Read time: 64; Write time: 196048 11:10:20 INFO - Running post-run listener: _upload_blobber_files 11:10:20 INFO - Blob upload gear active. 11:10:20 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 11:10:20 INFO - Copying logs to upload dir... 11:10:20 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1255.499797 ========= master_lag: 0.23 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 55 secs) (at 2015-11-23 11:10:20.577410) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-23 11:10:20.580649) ========= 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=fdc9337702648c539b2c5dbe000001aa-1448303012.774549-125941606 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/022i7NZkTzWU93J-RU684Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.010102 build_url: 'https://queue.taskcluster.net/v1/task/022i7NZkTzWU93J-RU684Q/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-23 11:10:20.633044) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 11:10:20.633444) ========= 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=fdc9337702648c539b2c5dbe000001aa-1448303012.774549-125941606 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004549 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 11:10:20.683116) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-23 11:10:20.683452) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-23 11:10:20.683793) ========= ========= Total master_lag: 0.39 =========