builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-027 starttime: 1448077237.55 results: success (0) buildid: 20151120173025 builduid: 651ab1dec87a48b596125f5f8a8ea728 revision: 809ef65b4a96cfb02ef3acfdb664fa03394a0195 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-11-20 19:40:37.546192) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-11-20 19:40:37.546715) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-20 19:40:37.547142) ========= 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=447a3abc0420b6a47dd38cba000001bf-1448075675.772729-229027168 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006648 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-20 19:40:37.576937) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-20 19:40:37.577222) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-20 19:40:37.593574) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-20 19:40:37.593958) ========= 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=447a3abc0420b6a47dd38cba000001bf-1448075675.772729-229027168 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004562 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-20 19:40:37.643729) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-20 19:40:37.644048) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-20 19:40:37.644456) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-20 19:40:37.644729) ========= 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=447a3abc0420b6a47dd38cba000001bf-1448075675.772729-229027168 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-11-20 19:40:37-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 43.6M=0s 2015-11-20 19:40:37 (43.6 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.106024 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-20 19:40:37.763007) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-20 19:40:37.763340) ========= 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=447a3abc0420b6a47dd38cba000001bf-1448075675.772729-229027168 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.022109 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-20 19:40:37.819864) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-20 19:40:37.820180) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 809ef65b4a96cfb02ef3acfdb664fa03394a0195 --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 809ef65b4a96cfb02ef3acfdb664fa03394a0195 --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=447a3abc0420b6a47dd38cba000001bf-1448075675.772729-229027168 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-11-20 19:40:37,980 truncating revision to first 12 chars 2015-11-20 19:40:37,980 Setting DEBUG logging. 2015-11-20 19:40:37,980 attempt 1/10 2015-11-20 19:40:37,980 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/809ef65b4a96?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-11-20 19:40:38,215 unpacking tar archive at: fx-team-809ef65b4a96/testing/mozharness/ program finished with exit code 0 elapsedTime=0.526540 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-20 19:40:38.360414) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-20 19:40:38.360715) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-20 19:40:38.370608) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-20 19:40:38.371165) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-20 19:40:38.371617) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 2 secs) (at 2015-11-20 19:40:38.371895) ========= /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=447a3abc0420b6a47dd38cba000001bf-1448075675.772729-229027168 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 19:40:38 INFO - MultiFileLogger online at 20151120 19:40:38 in /builds/slave/test-pgo 19:40:38 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 19:40:38 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 19:40:38 INFO - {'append_to_log': False, 19:40:38 INFO - 'base_work_dir': '/builds/slave/test-pgo', 19:40:38 INFO - 'blob_upload_branch': 'Fx-Team', 19:40:38 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 19:40:38 INFO - 'branch': 'Fx-Team', 19:40:38 INFO - 'buildbot_json_path': 'buildprops.json', 19:40:38 INFO - 'config_files': ('talos/linux_config.py',), 19:40:38 INFO - 'default_actions': ('clobber', 19:40:38 INFO - 'read-buildbot-config', 19:40:38 INFO - 'download-and-extract', 19:40:38 INFO - 'populate-webroot', 19:40:38 INFO - 'create-virtualenv', 19:40:38 INFO - 'install', 19:40:38 INFO - 'run-tests'), 19:40:38 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 19:40:38 INFO - 'download_minidump_stackwalk': True, 19:40:38 INFO - 'download_symbols': 'ondemand', 19:40:38 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 19:40:38 INFO - 'tooltool.py': '/tools/tooltool.py', 19:40:38 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 19:40:38 INFO - '/tools/misc-python/virtualenv.py')}, 19:40:38 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 19:40:38 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 19:40:38 INFO - 'installer_path': 'installer.exe', 19:40:38 INFO - 'log_level': 'info', 19:40:38 INFO - 'log_name': 'talos', 19:40:38 INFO - 'log_to_console': True, 19:40:38 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 19:40:38 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 19:40:38 INFO - 'opt_config_files': (), 19:40:38 INFO - 'pip_index': False, 19:40:38 INFO - 'sps_profile': False, 19:40:38 INFO - 'sps_profile_interval': 0, 19:40:38 INFO - 'suite': 'dromaeojs', 19:40:38 INFO - 'system_bits': '64', 19:40:38 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 19:40:38 INFO - 'title': 'talos-linux64-ix-027', 19:40:38 INFO - 'tooltool_cache': '/builds/tooltool_cache', 19:40:38 INFO - 'use_talos_json': True, 19:40:38 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 19:40:38 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 19:40:38 INFO - 'work_dir': 'build'} 19:40:38 INFO - ##### 19:40:38 INFO - ##### Running clobber step. 19:40:38 INFO - ##### 19:40:38 INFO - Running pre-action listener: _resource_record_pre_action 19:40:38 INFO - Running main action method: clobber 19:40:38 INFO - rmtree: /builds/slave/test-pgo/build 19:40:38 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 19:40:39 INFO - Running post-action listener: _resource_record_post_action 19:40:39 INFO - ##### 19:40:39 INFO - ##### Running read-buildbot-config step. 19:40:39 INFO - ##### 19:40:39 INFO - Running pre-action listener: _resource_record_pre_action 19:40:39 INFO - Running main action method: read_buildbot_config 19:40:39 INFO - Using buildbot properties: 19:40:39 INFO - { 19:40:39 INFO - "properties": { 19:40:39 INFO - "buildnumber": 796, 19:40:39 INFO - "product": "firefox", 19:40:39 INFO - "script_repo_revision": "production", 19:40:39 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 19:40:39 INFO - "repository": "", 19:40:39 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 19:40:39 INFO - "buildid": "20151120173025", 19:40:39 INFO - "slavename": "talos-linux64-ix-027", 19:40:39 INFO - "pgo_build": "True", 19:40:39 INFO - "basedir": "/builds/slave/test-pgo", 19:40:39 INFO - "project": "", 19:40:39 INFO - "platform": "ubuntu64_hw", 19:40:39 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 19:40:39 INFO - "slavebuilddir": "test", 19:40:39 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 19:40:39 INFO - "branch": "fx-team", 19:40:39 INFO - "repo_path": "integration/fx-team", 19:40:39 INFO - "stage_platform": "linux64-pgo", 19:40:39 INFO - "builduid": "651ab1dec87a48b596125f5f8a8ea728", 19:40:39 INFO - "revision": "809ef65b4a96cfb02ef3acfdb664fa03394a0195" 19:40:39 INFO - }, 19:40:39 INFO - "sourcestamp": { 19:40:39 INFO - "repository": "", 19:40:39 INFO - "hasPatch": false, 19:40:39 INFO - "project": "", 19:40:39 INFO - "branch": "fx-team-linux64-pgo-talos", 19:40:39 INFO - "changes": [ 19:40:39 INFO - { 19:40:39 INFO - "category": null, 19:40:39 INFO - "files": [ 19:40:39 INFO - { 19:40:39 INFO - "url": null, 19:40:39 INFO - "name": "https://queue.taskcluster.net/v1/task/hn4PGcklSIOWRxOdnWaotQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2" 19:40:39 INFO - } 19:40:39 INFO - ], 19:40:39 INFO - "repository": "", 19:40:39 INFO - "rev": "809ef65b4a96cfb02ef3acfdb664fa03394a0195", 19:40:39 INFO - "who": "sendchange", 19:40:39 INFO - "when": 1448077196, 19:40:39 INFO - "number": 6691820, 19:40:39 INFO - "comments": "", 19:40:39 INFO - "project": "", 19:40:39 INFO - "at": "Fri 20 Nov 2015 19:39:56", 19:40:39 INFO - "branch": "fx-team-linux64-pgo-talos", 19:40:39 INFO - "revlink": "", 19:40:39 INFO - "properties": [ 19:40:39 INFO - [ 19:40:39 INFO - "buildid", 19:40:39 INFO - "20151120173025", 19:40:39 INFO - "Change" 19:40:39 INFO - ], 19:40:39 INFO - [ 19:40:39 INFO - "builduid", 19:40:39 INFO - "651ab1dec87a48b596125f5f8a8ea728", 19:40:39 INFO - "Change" 19:40:39 INFO - ], 19:40:39 INFO - [ 19:40:39 INFO - "pgo_build", 19:40:39 INFO - "True", 19:40:39 INFO - "Change" 19:40:39 INFO - ] 19:40:39 INFO - ], 19:40:39 INFO - "revision": "809ef65b4a96cfb02ef3acfdb664fa03394a0195" 19:40:39 INFO - } 19:40:39 INFO - ], 19:40:39 INFO - "revision": "809ef65b4a96cfb02ef3acfdb664fa03394a0195" 19:40:39 INFO - } 19:40:39 INFO - } 19:40:39 INFO - Found installer url https://queue.taskcluster.net/v1/task/hn4PGcklSIOWRxOdnWaotQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2. 19:40:39 INFO - Running post-action listener: _resource_record_post_action 19:40:39 INFO - ##### 19:40:39 INFO - ##### Running download-and-extract step. 19:40:39 INFO - ##### 19:40:39 INFO - Running pre-action listener: _resource_record_pre_action 19:40:39 INFO - Running main action method: download_and_extract 19:40:39 INFO - mkdir: /builds/slave/test-pgo/build/tests 19:40:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:40:39 INFO - https://queue.taskcluster.net/v1/task/hn4PGcklSIOWRxOdnWaotQ/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 19:40:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/hn4PGcklSIOWRxOdnWaotQ/artifacts/public/build/test_packages.json 19:40:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/hn4PGcklSIOWRxOdnWaotQ/artifacts/public/build/test_packages.json 19:40:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/hn4PGcklSIOWRxOdnWaotQ/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 19:40:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/hn4PGcklSIOWRxOdnWaotQ/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 19:40:40 INFO - Downloaded 1302 bytes. 19:40:40 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 19:40:40 INFO - Using the following test package requirements: 19:40:40 INFO - {u'common': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 19:40:40 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 19:40:40 INFO - u'firefox-45.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 19:40:40 INFO - u'jittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 19:40:40 INFO - u'jsshell-linux-x86_64.zip'], 19:40:40 INFO - u'mochitest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 19:40:40 INFO - u'firefox-45.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 19:40:40 INFO - u'mozbase': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 19:40:40 INFO - u'reftest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 19:40:40 INFO - u'firefox-45.0a1.en-US.linux-x86_64.reftest.tests.zip'], 19:40:40 INFO - u'talos': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 19:40:40 INFO - u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'], 19:40:40 INFO - u'web-platform': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 19:40:40 INFO - u'firefox-45.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 19:40:40 INFO - u'webapprt': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 19:40:40 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 19:40:40 INFO - u'firefox-45.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 19:40:40 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 19:40: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')]} 19:40:40 INFO - https://queue.taskcluster.net/v1/task/hn4PGcklSIOWRxOdnWaotQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 19:40:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/hn4PGcklSIOWRxOdnWaotQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 19:40:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/hn4PGcklSIOWRxOdnWaotQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 19:40:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/hn4PGcklSIOWRxOdnWaotQ/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 19:40:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/hn4PGcklSIOWRxOdnWaotQ/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 19:40:41 INFO - Downloaded 22523880 bytes. 19:40:41 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test-pgo/build/tests 19:40:41 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 19:40:41 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 19:40:42 INFO - Return code: 0 19:40:42 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 19:40: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')]} 19:40:42 INFO - https://queue.taskcluster.net/v1/task/hn4PGcklSIOWRxOdnWaotQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 19:40:42 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/hn4PGcklSIOWRxOdnWaotQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 19:40:42 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/hn4PGcklSIOWRxOdnWaotQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 19:40:42 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/hn4PGcklSIOWRxOdnWaotQ/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 19:40:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/hn4PGcklSIOWRxOdnWaotQ/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 19:40:50 INFO - Downloaded 22523880 bytes. 19:40:50 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 19:40:50 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 19:40:50 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 19:40:51 INFO - Return code: 0 19:40:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:40:51 INFO - https://queue.taskcluster.net/v1/task/hn4PGcklSIOWRxOdnWaotQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 19:40:51 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/hn4PGcklSIOWRxOdnWaotQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 19:40:51 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/hn4PGcklSIOWRxOdnWaotQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 19:40:51 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/hn4PGcklSIOWRxOdnWaotQ/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 19:40:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/hn4PGcklSIOWRxOdnWaotQ/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 19:40:52 INFO - Downloaded 11130997 bytes. 19:40:52 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 19:40:52 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 19:40:52 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 19:40:52 INFO - Return code: 0 19:40: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')]} 19:40:52 INFO - https://queue.taskcluster.net/v1/task/hn4PGcklSIOWRxOdnWaotQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 19:40:52 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/hn4PGcklSIOWRxOdnWaotQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 19:40:52 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/hn4PGcklSIOWRxOdnWaotQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 19:40:52 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/hn4PGcklSIOWRxOdnWaotQ/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 19:40:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/hn4PGcklSIOWRxOdnWaotQ/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 19:40:53 INFO - Downloaded 57449998 bytes. 19:40:53 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/hn4PGcklSIOWRxOdnWaotQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 19:40:53 INFO - mkdir: /builds/slave/test-pgo/properties 19:40:53 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 19:40:53 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 19:40:53 INFO - Contents: 19:40:53 INFO - build_url:https://queue.taskcluster.net/v1/task/hn4PGcklSIOWRxOdnWaotQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 19:40:53 INFO - Running post-action listener: _resource_record_post_action 19:40:53 INFO - Running post-action listener: set_extra_try_arguments 19:40:53 INFO - ##### 19:40:53 INFO - ##### Running populate-webroot step. 19:40:53 INFO - ##### 19:40:53 INFO - Running pre-action listener: _resource_record_pre_action 19:40:53 INFO - Running main action method: populate_webroot 19:40:53 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 19:40:53 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 19:40:53 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 19:40:53 INFO - '../fennec_ids.txt'], 19:40:53 INFO - 'tests': ['tcheck2']}, 19:40:53 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 19:40:53 INFO - '--tppagecycles', 19:40:53 INFO - '7'], 19:40:53 INFO - 'tests': ['tsvgm']}}, 19:40:53 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 19:40:53 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 19:40:53 INFO - 'tests': ['tresize', 'tcanvasmark']}, 19:40:53 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 19:40:53 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 19:40:53 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 19:40:53 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:40:53 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:40:53 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:40:53 INFO - 'talos_options': ['--e10s'], 19:40:53 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:40:53 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:40:53 INFO - 'tests': ['damp', 'tps']}, 19:40:53 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:40:53 INFO - 'talos_options': ['--e10s'], 19:40:53 INFO - 'tests': ['damp', 'tps']}, 19:40:53 INFO - 'g3': {'tests': ['dromaeo_dom']}, 19:40:53 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 19:40:53 INFO - 'other': {'tests': ['a11yr', 19:40:53 INFO - 'ts_paint', 19:40:53 INFO - 'tpaint', 19:40:53 INFO - 'sessionrestore', 19:40:53 INFO - 'sessionrestore_no_auto_restore']}, 19:40:53 INFO - 'other-e10s': {'talos_options': ['--e10s'], 19:40:53 INFO - 'tests': ['a11yr', 19:40:53 INFO - 'ts_paint', 19:40:53 INFO - 'tpaint', 19:40:53 INFO - 'sessionrestore', 19:40:53 INFO - 'sessionrestore_no_auto_restore']}, 19:40:53 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 19:40:53 INFO - 'tests': ['a11yr', 19:40:53 INFO - 'ts_paint', 19:40:53 INFO - 'tpaint', 19:40:53 INFO - 'sessionrestore', 19:40:53 INFO - 'sessionrestore_no_auto_restore']}, 19:40:53 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 19:40:53 INFO - 'tests': ['a11yr', 19:40:53 INFO - 'ts_paint', 19:40:53 INFO - 'tpaint', 19:40:53 INFO - 'sessionrestore', 19:40:53 INFO - 'sessionrestore_no_auto_restore']}, 19:40:53 INFO - 'other_l64': {'tests': ['a11yr', 19:40:53 INFO - 'ts_paint', 19:40:53 INFO - 'tpaint', 19:40:53 INFO - 'sessionrestore', 19:40:53 INFO - 'sessionrestore_no_auto_restore']}, 19:40:53 INFO - 'other_nol64': {'tests': ['a11yr', 19:40:53 INFO - 'ts_paint', 19:40:53 INFO - 'tpaint', 19:40:53 INFO - 'sessionrestore', 19:40:53 INFO - 'sessionrestore_no_auto_restore']}, 19:40:53 INFO - 'svgr': {'tests': ['tsvgx', 19:40:53 INFO - 'tsvgr_opacity', 19:40:53 INFO - 'tart', 19:40:53 INFO - 'tscrollx', 19:40:53 INFO - 'cart']}, 19:40:53 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 19:40:53 INFO - 'tests': ['tsvgx', 19:40:53 INFO - 'tsvgr_opacity', 19:40:53 INFO - 'tart', 19:40:53 INFO - 'tscrollx', 19:40:53 INFO - 'cart']}, 19:40:53 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:40:53 INFO - 'tests': ['tp5o']}, 19:40:53 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:40:53 INFO - 'talos_options': ['--e10s'], 19:40:53 INFO - 'tests': ['tp5o']}, 19:40:53 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:40:53 INFO - 'talos_options': ['--xperf_path', 19:40:53 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:40:53 INFO - 'tests': ['tp5n']}, 19:40:53 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:40:53 INFO - 'talos_options': ['--e10s', 19:40:53 INFO - '--xperf_path', 19:40:53 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:40:53 INFO - 'tests': ['tp5n']}}, 19:40:53 INFO - 'talos.zip': {'path': '', 19:40:53 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 19:40:53 INFO - Running post-action listener: _resource_record_post_action 19:40:53 INFO - ##### 19:40:53 INFO - ##### Running create-virtualenv step. 19:40:53 INFO - ##### 19:40:53 INFO - Running pre-action listener: _resource_record_pre_action 19:40:53 INFO - Running main action method: create_virtualenv 19:40:53 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 19:40:53 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 19:40:53 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 19:40:53 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 19:40:53 INFO - Using real prefix '/usr' 19:40:53 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 19:40:54 INFO - Installing distribute.............................................................................................................................................................................................done. 19:40:56 INFO - Installing pip.................done. 19:40:56 INFO - Return code: 0 19:40:56 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 19:40:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:40:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:40:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:40:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:40:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:40:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:40:56 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb52ada3c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26026c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26c36e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26f9a90>, '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 0x274bf70>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x274c2e0>, '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': '447a3abc0420b6a47dd38cba000001bf-1448075675.772729-229027168', '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 19:40:56 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test-pgo/build 19:40:56 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 19:40:56 INFO - Using env: {'DISPLAY': ':0', 19:40:56 INFO - 'HOME': '/home/cltbld', 19:40:56 INFO - 'LANG': 'en_US.UTF-8', 19:40:56 INFO - 'LANGUAGE': 'en_US:en', 19:40:56 INFO - 'LOGNAME': 'cltbld', 19:40:56 INFO - 'MAIL': '/var/mail/cltbld', 19:40:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:40:56 INFO - 'MOZ_NO_REMOTE': '1', 19:40:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:40:56 INFO - 'NO_EM_RESTART': '1', 19:40:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:40:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:40:56 INFO - 'PWD': '/builds/slave/test-pgo', 19:40:56 INFO - 'SHELL': '/bin/bash', 19:40:56 INFO - 'SHLVL': '1', 19:40:56 INFO - 'TERM': 'linux', 19:40:56 INFO - 'TMOUT': '86400', 19:40:56 INFO - 'USER': 'cltbld', 19:40:56 INFO - 'XDG_SESSION_COOKIE': '447a3abc0420b6a47dd38cba000001bf-1448075675.772729-229027168', 19:40:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:40:56 INFO - '_': '/tools/buildbot/bin/python'} 19:40:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:40:56 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 19:40:56 INFO - Cleaning up... 19:40:56 INFO - Return code: 0 19:40:56 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 19:40:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:40:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:40:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:40:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:40:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:40:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:40:56 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fb52ada3c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26026c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26c36e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26f9a90>, '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 0x274bf70>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x274c2e0>, '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': '447a3abc0420b6a47dd38cba000001bf-1448075675.772729-229027168', '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 19:40:56 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test-pgo/build 19:40:56 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 19:40:56 INFO - Using env: {'DISPLAY': ':0', 19:40:56 INFO - 'HOME': '/home/cltbld', 19:40:56 INFO - 'LANG': 'en_US.UTF-8', 19:40:56 INFO - 'LANGUAGE': 'en_US:en', 19:40:56 INFO - 'LOGNAME': 'cltbld', 19:40:56 INFO - 'MAIL': '/var/mail/cltbld', 19:40:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:40:56 INFO - 'MOZ_NO_REMOTE': '1', 19:40:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:40:56 INFO - 'NO_EM_RESTART': '1', 19:40:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:40:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:40:56 INFO - 'PWD': '/builds/slave/test-pgo', 19:40:56 INFO - 'SHELL': '/bin/bash', 19:40:56 INFO - 'SHLVL': '1', 19:40:56 INFO - 'TERM': 'linux', 19:40:56 INFO - 'TMOUT': '86400', 19:40:56 INFO - 'USER': 'cltbld', 19:40:56 INFO - 'XDG_SESSION_COOKIE': '447a3abc0420b6a47dd38cba000001bf-1448075675.772729-229027168', 19:40:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:40:56 INFO - '_': '/tools/buildbot/bin/python'} 19:40:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:40:56 INFO - Downloading/unpacking psutil>=0.7.1 19:40:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:40:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:40:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:40:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:40:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:40:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:40:58 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 19:40:58 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 19:40:58 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 19:40:58 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:40:58 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:40:58 INFO - Installing collected packages: psutil 19:40:58 INFO - Running setup.py install for psutil 19:40:58 INFO - building 'psutil._psutil_linux' extension 19:40:58 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 19:40:59 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 19:40:59 INFO - building 'psutil._psutil_posix' extension 19:40:59 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 19:40:59 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 19:40:59 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:40:59 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:40:59 INFO - Successfully installed psutil 19:40:59 INFO - Cleaning up... 19:40:59 INFO - Return code: 0 19:40:59 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 19:40:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:40:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:40:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:40:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:40:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:40:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:40:59 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 0x7fb52ada3c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26026c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26c36e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26f9a90>, '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 0x274bf70>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x274c2e0>, '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': '447a3abc0420b6a47dd38cba000001bf-1448075675.772729-229027168', '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 19:40:59 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 19:40:59 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 19:40:59 INFO - Using env: {'DISPLAY': ':0', 19:40:59 INFO - 'HOME': '/home/cltbld', 19:40:59 INFO - 'LANG': 'en_US.UTF-8', 19:40:59 INFO - 'LANGUAGE': 'en_US:en', 19:40:59 INFO - 'LOGNAME': 'cltbld', 19:40:59 INFO - 'MAIL': '/var/mail/cltbld', 19:40:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:40:59 INFO - 'MOZ_NO_REMOTE': '1', 19:40:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:40:59 INFO - 'NO_EM_RESTART': '1', 19:40:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:40:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:40:59 INFO - 'PWD': '/builds/slave/test-pgo', 19:40:59 INFO - 'SHELL': '/bin/bash', 19:40:59 INFO - 'SHLVL': '1', 19:40:59 INFO - 'TERM': 'linux', 19:40:59 INFO - 'TMOUT': '86400', 19:40:59 INFO - 'USER': 'cltbld', 19:40:59 INFO - 'XDG_SESSION_COOKIE': '447a3abc0420b6a47dd38cba000001bf-1448075675.772729-229027168', 19:40:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:40:59 INFO - '_': '/tools/buildbot/bin/python'} 19:40:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:40:59 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 19:40:59 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 19:40:59 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 19:40:59 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 19:40:59 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 19:40:59 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 19:40:59 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 19:41:01 INFO - Downloading mozsystemmonitor-0.0.tar.gz 19:41:01 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 19:41:01 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 19:41:01 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 19:41:01 INFO - Installing collected packages: mozsystemmonitor 19:41:01 INFO - Running setup.py install for mozsystemmonitor 19:41:01 INFO - Successfully installed mozsystemmonitor 19:41:01 INFO - Cleaning up... 19:41:01 INFO - Return code: 0 19:41:01 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 19:41:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:41:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:41:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:41:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:41:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:41:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:41:01 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 0x7fb52ada3c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26026c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26c36e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26f9a90>, '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 0x274bf70>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x274c2e0>, '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': '447a3abc0420b6a47dd38cba000001bf-1448075675.772729-229027168', '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 19:41:01 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 19:41:01 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 19:41:01 INFO - Using env: {'DISPLAY': ':0', 19:41:01 INFO - 'HOME': '/home/cltbld', 19:41:01 INFO - 'LANG': 'en_US.UTF-8', 19:41:01 INFO - 'LANGUAGE': 'en_US:en', 19:41:01 INFO - 'LOGNAME': 'cltbld', 19:41:01 INFO - 'MAIL': '/var/mail/cltbld', 19:41:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:41:01 INFO - 'MOZ_NO_REMOTE': '1', 19:41:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:41:01 INFO - 'NO_EM_RESTART': '1', 19:41:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:41:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:41:01 INFO - 'PWD': '/builds/slave/test-pgo', 19:41:01 INFO - 'SHELL': '/bin/bash', 19:41:01 INFO - 'SHLVL': '1', 19:41:01 INFO - 'TERM': 'linux', 19:41:01 INFO - 'TMOUT': '86400', 19:41:01 INFO - 'USER': 'cltbld', 19:41:01 INFO - 'XDG_SESSION_COOKIE': '447a3abc0420b6a47dd38cba000001bf-1448075675.772729-229027168', 19:41:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:41:01 INFO - '_': '/tools/buildbot/bin/python'} 19:41:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:41:01 INFO - Downloading/unpacking blobuploader==1.2.4 19:41:01 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 19:41:01 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 19:41:01 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 19:41:01 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 19:41:01 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 19:41:01 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 19:41:03 INFO - Downloading blobuploader-1.2.4.tar.gz 19:41:03 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 19:41:03 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 19:41:03 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 19:41:03 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 19:41:03 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 19:41:03 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 19:41:03 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 19:41:03 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 19:41:03 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 19:41:03 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 19:41:03 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 19:41:03 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 19:41:03 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 19:41:03 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 19:41:03 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 19:41:03 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 19:41:03 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 19:41:03 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 19:41:04 INFO - Downloading docopt-0.6.1.tar.gz 19:41:04 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 19:41:04 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 19:41:04 INFO - Installing collected packages: blobuploader, requests, docopt 19:41:04 INFO - Running setup.py install for blobuploader 19:41:04 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 19:41:04 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 19:41:04 INFO - Running setup.py install for requests 19:41:04 INFO - Running setup.py install for docopt 19:41:04 INFO - Successfully installed blobuploader requests docopt 19:41:04 INFO - Cleaning up... 19:41:04 INFO - Return code: 0 19:41:04 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 19:41:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:41:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:41:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:41:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:41:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:41:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:41:04 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 0x7fb52ada3c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26026c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26c36e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26f9a90>, '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 0x274bf70>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x274c2e0>, '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': '447a3abc0420b6a47dd38cba000001bf-1448075675.772729-229027168', '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 19:41:04 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 19:41:04 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 19:41:04 INFO - Using env: {'DISPLAY': ':0', 19:41:04 INFO - 'HOME': '/home/cltbld', 19:41:04 INFO - 'LANG': 'en_US.UTF-8', 19:41:04 INFO - 'LANGUAGE': 'en_US:en', 19:41:04 INFO - 'LOGNAME': 'cltbld', 19:41:04 INFO - 'MAIL': '/var/mail/cltbld', 19:41:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:41:04 INFO - 'MOZ_NO_REMOTE': '1', 19:41:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:41:04 INFO - 'NO_EM_RESTART': '1', 19:41:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:41:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:41:04 INFO - 'PWD': '/builds/slave/test-pgo', 19:41:04 INFO - 'SHELL': '/bin/bash', 19:41:04 INFO - 'SHLVL': '1', 19:41:04 INFO - 'TERM': 'linux', 19:41:04 INFO - 'TMOUT': '86400', 19:41:04 INFO - 'USER': 'cltbld', 19:41:04 INFO - 'XDG_SESSION_COOKIE': '447a3abc0420b6a47dd38cba000001bf-1448075675.772729-229027168', 19:41:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:41:04 INFO - '_': '/tools/buildbot/bin/python'} 19:41:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:41:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 19:41:05 INFO - Running setup.py (path:/tmp/pip-_MJ4Gx-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 19:41:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 19:41:05 INFO - Running setup.py (path:/tmp/pip-TfD_7n-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 19:41:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 19:41:05 INFO - Running setup.py (path:/tmp/pip-05lh3l-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 19:41:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 19:41:05 INFO - Running setup.py (path:/tmp/pip-PErICf-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 19:41:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 19:41:05 INFO - Running setup.py (path:/tmp/pip-9Hkdlr-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 19:41:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 19:41:05 INFO - Running setup.py (path:/tmp/pip-7McneY-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 19:41:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 19:41:05 INFO - Running setup.py (path:/tmp/pip-3k0afp-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 19:41:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 19:41:05 INFO - Running setup.py (path:/tmp/pip-HA7Gpp-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 19:41:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 19:41:05 INFO - Running setup.py (path:/tmp/pip-1TfNHP-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 19:41:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 19:41:05 INFO - Running setup.py (path:/tmp/pip-4tXR8U-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 19:41:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 19:41:05 INFO - Running setup.py (path:/tmp/pip-RqGZJ5-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 19:41:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 19:41:05 INFO - Running setup.py (path:/tmp/pip-8WPAdX-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 19:41:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 19:41:05 INFO - Running setup.py (path:/tmp/pip-7qowXc-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 19:41:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 19:41:05 INFO - Running setup.py (path:/tmp/pip-K9V6Hh-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 19:41:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 19:41:06 INFO - Running setup.py (path:/tmp/pip-mQpSIN-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 19:41:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 19:41:06 INFO - Running setup.py (path:/tmp/pip-kgXIH7-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 19:41:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 19:41:06 INFO - Running setup.py (path:/tmp/pip-qWzAa0-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 19:41:06 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 19:41:06 INFO - Running setup.py install for manifestparser 19:41:06 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 19:41:06 INFO - Running setup.py install for mozcrash 19:41:06 INFO - Running setup.py install for mozdebug 19:41:06 INFO - Running setup.py install for mozdevice 19:41:06 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 19:41:06 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 19:41:06 INFO - Running setup.py install for mozfile 19:41:06 INFO - Running setup.py install for mozhttpd 19:41:06 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 19:41:06 INFO - Running setup.py install for mozinfo 19:41:06 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 19:41:06 INFO - Running setup.py install for mozInstall 19:41:07 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 19:41:07 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 19:41:07 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 19:41:07 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 19:41:07 INFO - Running setup.py install for mozleak 19:41:07 INFO - Running setup.py install for mozlog 19:41:07 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 19:41:07 INFO - Running setup.py install for moznetwork 19:41:07 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 19:41:07 INFO - Running setup.py install for mozprocess 19:41:07 INFO - Running setup.py install for mozprofile 19:41:07 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 19:41:07 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 19:41:07 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 19:41:07 INFO - Running setup.py install for mozrunner 19:41:07 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 19:41:07 INFO - Running setup.py install for mozscreenshot 19:41:07 INFO - Running setup.py install for moztest 19:41:07 INFO - Running setup.py install for mozversion 19:41:07 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 19:41:08 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 19:41:08 INFO - Cleaning up... 19:41:08 INFO - Return code: 0 19:41:08 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 19:41: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')]} 19:41:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:41:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:41: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')]} 19:41:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:41:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:41:08 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 0x7fb52ada3c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26026c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26c36e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26f9a90>, '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 0x274bf70>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x274c2e0>, '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': '447a3abc0420b6a47dd38cba000001bf-1448075675.772729-229027168', '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 19:41:08 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 19:41:08 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 19:41:08 INFO - Using env: {'DISPLAY': ':0', 19:41:08 INFO - 'HOME': '/home/cltbld', 19:41:08 INFO - 'LANG': 'en_US.UTF-8', 19:41:08 INFO - 'LANGUAGE': 'en_US:en', 19:41:08 INFO - 'LOGNAME': 'cltbld', 19:41:08 INFO - 'MAIL': '/var/mail/cltbld', 19:41:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:41:08 INFO - 'MOZ_NO_REMOTE': '1', 19:41:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:41:08 INFO - 'NO_EM_RESTART': '1', 19:41:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:41:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:41:08 INFO - 'PWD': '/builds/slave/test-pgo', 19:41:08 INFO - 'SHELL': '/bin/bash', 19:41:08 INFO - 'SHLVL': '1', 19:41:08 INFO - 'TERM': 'linux', 19:41:08 INFO - 'TMOUT': '86400', 19:41:08 INFO - 'USER': 'cltbld', 19:41:08 INFO - 'XDG_SESSION_COOKIE': '447a3abc0420b6a47dd38cba000001bf-1448075675.772729-229027168', 19:41:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:41:08 INFO - '_': '/tools/buildbot/bin/python'} 19:41:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:41:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 19:41:08 INFO - Running setup.py (path:/tmp/pip-PynbF8-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 19:41:08 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)) 19:41:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 19:41:08 INFO - Running setup.py (path:/tmp/pip-3CoswC-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 19:41:08 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)) 19:41:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 19:41:08 INFO - Running setup.py (path:/tmp/pip-i4HSxl-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 19:41:08 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)) 19:41:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 19:41:08 INFO - Running setup.py (path:/tmp/pip-lRPyr8-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 19:41:08 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)) 19:41:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 19:41:08 INFO - Running setup.py (path:/tmp/pip-q7th_k-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 19:41:08 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)) 19:41:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 19:41:08 INFO - Running setup.py (path:/tmp/pip-SCU6xc-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 19:41:08 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)) 19:41:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 19:41:08 INFO - Running setup.py (path:/tmp/pip-2CiG4I-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 19:41:08 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)) 19:41:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 19:41:08 INFO - Running setup.py (path:/tmp/pip-rEmMar-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 19:41:08 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)) 19:41:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 19:41:08 INFO - Running setup.py (path:/tmp/pip-T0y33l-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 19:41:08 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)) 19:41:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 19:41:08 INFO - Running setup.py (path:/tmp/pip-pHDKLB-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 19:41:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.0 from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 19:41:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 19:41:08 INFO - Running setup.py (path:/tmp/pip-0orXfE-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 19:41:09 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)) 19:41:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 19:41:09 INFO - Running setup.py (path:/tmp/pip-IyQjco-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 19:41:09 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)) 19:41:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 19:41:09 INFO - Running setup.py (path:/tmp/pip-WeGR9x-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 19:41:09 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)) 19:41:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 19:41:09 INFO - Running setup.py (path:/tmp/pip-JKNB1k-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 19:41:09 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)) 19:41:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 19:41:09 INFO - Running setup.py (path:/tmp/pip-eJFmrE-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 19:41:09 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)) 19:41:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 19:41:09 INFO - Running setup.py (path:/tmp/pip-GuitPZ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 19:41:09 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)) 19:41:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 19:41:09 INFO - Running setup.py (path:/tmp/pip-pquVbL-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 19:41:09 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)) 19:41:09 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)) 19:41:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 19:41:09 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)) 19:41:09 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 19:41:09 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)) 19:41:09 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.0->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 19:41:09 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 19:41:09 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 19:41:09 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 19:41:09 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 19:41:09 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 19:41:09 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 19:41:11 INFO - Downloading blessings-1.5.1.tar.gz 19:41:11 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 19:41:11 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 19:41:11 INFO - Installing collected packages: blessings 19:41:11 INFO - Running setup.py install for blessings 19:41:11 INFO - Successfully installed blessings 19:41:11 INFO - Cleaning up... 19:41:11 INFO - Return code: 0 19:41:11 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 19:41:11 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 19:41:11 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 19:41:11 INFO - Reading from file tmpfile_stdout 19:41:11 INFO - Current package versions: 19:41:11 INFO - argparse == 1.2.1 19:41:11 INFO - blessings == 1.5.1 19:41:11 INFO - blobuploader == 1.2.4 19:41:11 INFO - docopt == 0.6.1 19:41:11 INFO - manifestparser == 1.1 19:41:11 INFO - mozInstall == 1.12 19:41:11 INFO - mozcrash == 0.16 19:41:11 INFO - mozdebug == 0.1 19:41:11 INFO - mozdevice == 0.47 19:41:11 INFO - mozfile == 1.2 19:41:11 INFO - mozhttpd == 0.7 19:41:11 INFO - mozinfo == 0.9 19:41:11 INFO - mozleak == 0.1 19:41:11 INFO - mozlog == 3.0 19:41:11 INFO - moznetwork == 0.27 19:41:11 INFO - mozprocess == 0.22 19:41:11 INFO - mozprofile == 0.27 19:41:11 INFO - mozrunner == 6.11 19:41:11 INFO - mozscreenshot == 0.1 19:41:11 INFO - mozsystemmonitor == 0.0 19:41:11 INFO - moztest == 0.7 19:41:11 INFO - mozversion == 1.4 19:41:11 INFO - psutil == 3.1.1 19:41:11 INFO - requests == 1.2.3 19:41:11 INFO - wsgiref == 0.1.2 19:41:11 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 19:41:11 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')]} 19:41:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:41:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:41:11 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')]} 19:41:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:41:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:41:11 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 0x7fb52ada3c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26026c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26c36e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26f9a90>, '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 0x274bf70>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x274c2e0>, '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': '447a3abc0420b6a47dd38cba000001bf-1448075675.772729-229027168', '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 19:41:11 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 19:41:11 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 19:41:11 INFO - Using env: {'DISPLAY': ':0', 19:41:11 INFO - 'HOME': '/home/cltbld', 19:41:11 INFO - 'LANG': 'en_US.UTF-8', 19:41:11 INFO - 'LANGUAGE': 'en_US:en', 19:41:11 INFO - 'LOGNAME': 'cltbld', 19:41:11 INFO - 'MAIL': '/var/mail/cltbld', 19:41:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:41:11 INFO - 'MOZ_NO_REMOTE': '1', 19:41:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:41:11 INFO - 'NO_EM_RESTART': '1', 19:41:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:41:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:41:11 INFO - 'PWD': '/builds/slave/test-pgo', 19:41:11 INFO - 'SHELL': '/bin/bash', 19:41:11 INFO - 'SHLVL': '1', 19:41:11 INFO - 'TERM': 'linux', 19:41:11 INFO - 'TMOUT': '86400', 19:41:11 INFO - 'USER': 'cltbld', 19:41:11 INFO - 'XDG_SESSION_COOKIE': '447a3abc0420b6a47dd38cba000001bf-1448075675.772729-229027168', 19:41:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:41:11 INFO - '_': '/tools/buildbot/bin/python'} 19:41:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:41:11 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)) 19:41:11 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)) 19:41:11 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)) 19:41:11 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)) 19:41:11 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)) 19:41:11 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)) 19:41:11 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)) 19:41:11 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)) 19:41:11 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)) 19:41:11 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)) 19:41:11 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)) 19:41:11 INFO - Cleaning up... 19:41:11 INFO - Return code: 0 19:41:11 INFO - Running post-action listener: _resource_record_post_action 19:41:11 INFO - Running post-action listener: _start_resource_monitoring 19:41:11 INFO - Starting resource monitoring. 19:41:11 INFO - ##### 19:41:11 INFO - ##### Running install step. 19:41:11 INFO - ##### 19:41:11 INFO - Running pre-action listener: _resource_record_pre_action 19:41:11 INFO - Running main action method: install 19:41:11 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 19:41:11 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 19:41:12 INFO - Reading from file tmpfile_stdout 19:41:12 INFO - Detecting whether we're running mozinstall >=1.0... 19:41:12 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 19:41:12 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 19:41:12 INFO - Reading from file tmpfile_stdout 19:41:12 INFO - Output received: 19:41:12 INFO - Usage: mozinstall [options] installer 19:41:12 INFO - Options: 19:41:12 INFO - -h, --help show this help message and exit 19:41:12 INFO - -d DEST, --destination=DEST 19:41:12 INFO - Directory to install application into. [default: 19:41:12 INFO - "/builds/slave/test-pgo"] 19:41:12 INFO - --app=APP Application being installed. [default: firefox] 19:41:12 INFO - mkdir: /builds/slave/test-pgo/build/application 19:41:12 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'] 19:41:12 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 19:41:26 INFO - Reading from file tmpfile_stdout 19:41:26 INFO - Output received: 19:41:26 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 19:41:26 INFO - Running post-action listener: _resource_record_post_action 19:41:26 INFO - ##### 19:41:26 INFO - ##### Running run-tests step. 19:41:26 INFO - ##### 19:41:26 INFO - Running pre-action listener: _resource_record_pre_action 19:41:26 INFO - Running main action method: run_tests 19:41:26 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 19:41:26 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 19:41:26 INFO - Python 2.7.3 19:41:26 INFO - Return code: 0 19:41:26 INFO - grabbing minidump binary from tooltool 19:41: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')]} 19:41:26 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 0x26f9a90>, '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 0x274bf70>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x274c2e0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 19:41:26 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 19:41:26 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 19:41:26 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 19:41:26 INFO - Return code: 0 19:41:26 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 19:41:26 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 19:41:26 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 19:41:26 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 19:41:26 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 19:41:26 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/hn4PGcklSIOWRxOdnWaotQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-027', '--webServer', 'localhost'] in /builds/slave/test-pgo/build 19:41:26 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/hn4PGcklSIOWRxOdnWaotQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-027 --webServer localhost 19:41:26 INFO - Using env: {'DISPLAY': ':0', 19:41:26 INFO - 'HOME': '/home/cltbld', 19:41:26 INFO - 'LANG': 'en_US.UTF-8', 19:41:26 INFO - 'LANGUAGE': 'en_US:en', 19:41:26 INFO - 'LOGNAME': 'cltbld', 19:41:26 INFO - 'MAIL': '/var/mail/cltbld', 19:41:26 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 19:41:26 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 19:41:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:41:26 INFO - 'MOZ_NO_REMOTE': '1', 19:41:26 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 19:41:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:41:26 INFO - 'NO_EM_RESTART': '1', 19:41:26 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:41:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:41:26 INFO - 'PWD': '/builds/slave/test-pgo', 19:41:26 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 19:41:26 INFO - 'SHELL': '/bin/bash', 19:41:26 INFO - 'SHLVL': '1', 19:41:26 INFO - 'TERM': 'linux', 19:41:26 INFO - 'TMOUT': '86400', 19:41:26 INFO - 'USER': 'cltbld', 19:41:26 INFO - 'XDG_SESSION_COOKIE': '447a3abc0420b6a47dd38cba000001bf-1448075675.772729-229027168', 19:41:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:41:26 INFO - '_': '/tools/buildbot/bin/python'} 19:41:26 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/hn4PGcklSIOWRxOdnWaotQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-027', '--webServer', 'localhost'] with output_timeout 3600 19:41:26 INFO - mozversion INFO | application_buildid: 20151120173025 19:41:26 INFO - mozversion INFO | application_changeset: 809ef65b4a96cfb02ef3acfdb664fa03394a0195 19:41:26 INFO - mozversion INFO | application_display_name: Nightly 19:41:26 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 19:41:26 INFO - mozversion INFO | application_name: Firefox 19:41:26 INFO - mozversion INFO | application_remotingname: firefox 19:41:26 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/fx-team 19:41:26 INFO - mozversion INFO | application_vendor: Mozilla 19:41:26 INFO - mozversion INFO | application_version: 45.0a1 19:41:26 INFO - mozversion INFO | platform_buildid: 20151120173025 19:41:26 INFO - mozversion INFO | platform_changeset: 809ef65b4a96cfb02ef3acfdb664fa03394a0195 19:41:26 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/fx-team 19:41:26 INFO - mozversion INFO | platform_version: 45.0a1 19:41:26 INFO - 2015-11-20 19:41:26,863 DEBUG : using testdate: 1448077286 19:41:26 INFO - 2015-11-20 19:41:26,863 DEBUG : actual date: 1448077286 19:41:26 INFO - 2015-11-20 19:41:26,945 INFO : starting webserver on 'localhost:41543' 19:41:26 INFO - 2015-11-20 19:41:26,946 INFO : Starting test suite talos-linux64-ix-027 19:41:26 INFO - 2015-11-20 19:41:26,946 INFO : Starting test dromaeo_css 19:41:26 INFO - 2015-11-20 19:41:26,946 DEBUG : operating with platform_type : linux_ 19:41:26 INFO - 2015-11-20 19:41:26,947 INFO : Initialising browser for dromaeo_css test... 19:41:26 INFO - 2015-11-20 19:41:26,959 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpl3axwp/profile http://localhost:41543/getInfo.html 19:41:31 INFO - 2015-11-20 19:41:31,150 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 19:41:31 INFO - 2015-11-20 19:41:31,150 DEBUG : BROWSER_OUTPUT: colorDepth:24 19:41:31 INFO - 2015-11-20 19:41:31,150 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 19:41:31 INFO - 2015-11-20 19:41:31,150 DEBUG : BROWSER_OUTPUT: __metrics 19:41:31 INFO - 2015-11-20 19:41:31,307 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 19:41:32 INFO - 2015-11-20 19:41:32,479 INFO : Browser initialized. 19:41:32 INFO - 2015-11-20 19:41:32,480 INFO : Running cycle 1/1 for dromaeo_css test... 19:41:32 INFO - 2015-11-20 19:41:32,480 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpl3axwp/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 19:41:44 INFO - 2015-11-20 19:41:44,270 DEBUG : BROWSER_OUTPUT: RSS: Main: 139829248 19:41:44 INFO - 2015-11-20 19:41:44,270 DEBUG : BROWSER_OUTPUT: 19:42:35 INFO - 2015-11-20 19:42:35,918 DEBUG : BROWSER_OUTPUT: 1448077355916 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] 19:44:44 INFO - 2015-11-20 19:44:44,677 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41543/tests/dromaeo/cssquery-dojo.html (next: http://localhost:41543/tests/dromaeo/cssquery-ext.html) 19:44:45 INFO - 2015-11-20 19:44:45,964 DEBUG : BROWSER_OUTPUT: RSS: Main: 227733504 19:44:45 INFO - 2015-11-20 19:44:45,964 DEBUG : BROWSER_OUTPUT: 19:47:48 INFO - 2015-11-20 19:47:48,257 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41543/tests/dromaeo/cssquery-ext.html (next: http://localhost:41543/tests/dromaeo/cssquery-jquery.html) 19:47:48 INFO - 2015-11-20 19:47:48,823 DEBUG : BROWSER_OUTPUT: RSS: Main: 223522816 19:47:48 INFO - 2015-11-20 19:47:48,823 DEBUG : BROWSER_OUTPUT: 19:50:50 INFO - 2015-11-20 19:50:50,817 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41543/tests/dromaeo/cssquery-jquery.html (next: http://localhost:41543/tests/dromaeo/cssquery-mootools.html) 19:50:51 INFO - 2015-11-20 19:50:51,386 DEBUG : BROWSER_OUTPUT: RSS: Main: 207351808 19:50:51 INFO - 2015-11-20 19:50:51,386 DEBUG : BROWSER_OUTPUT: 19:53:53 INFO - 2015-11-20 19:53:53,167 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41543/tests/dromaeo/cssquery-mootools.html (next: http://localhost:41543/tests/dromaeo/cssquery-prototype.html) 19:53:53 INFO - 2015-11-20 19:53:53,753 DEBUG : BROWSER_OUTPUT: RSS: Main: 200556544 19:53:53 INFO - 2015-11-20 19:53:53,753 DEBUG : BROWSER_OUTPUT: 19:56:56 INFO - 2015-11-20 19:56:56,235 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41543/tests/dromaeo/cssquery-prototype.html (next: http://localhost:41543/tests/dromaeo/cssquery-yui.html) 19:56:56 INFO - 2015-11-20 19:56:56,803 DEBUG : BROWSER_OUTPUT: RSS: Main: 202006528 19:56:56 INFO - 2015-11-20 19:56:56,804 DEBUG : BROWSER_OUTPUT: 19:59:59 INFO - 2015-11-20 19:59:59,766 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41543/tests/dromaeo/cssquery-yui.html (next: http://localhost:41543/tests/dromaeo/cssquery-dojo.html) 20:00:00 INFO - 2015-11-20 20:00:00,012 DEBUG : BROWSER_OUTPUT: RSS: Main: 223875072 20:00:00 INFO - 2015-11-20 20:00:00,012 DEBUG : BROWSER_OUTPUT: 20:00:00 INFO - 2015-11-20 20:00:00,013 DEBUG : BROWSER_OUTPUT: __start_tp_report 20:00:00 INFO - 2015-11-20 20:00:00,013 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 20:00:00 INFO - 2015-11-20 20:00:00,014 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 20:00:00 INFO - 2015-11-20 20:00:00,014 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 20:00:00 INFO - 2015-11-20 20:00:00,014 DEBUG : BROWSER_OUTPUT: |0;dojo.html;3167.144870884861;3235.7734958552883;3277.70500654941;3289.457239555475;3301.1252018215164;5123.205903085019;5212.087884620186;5265.973670131649;5375.139977603584;5484.725763711818;5271.4464981177;5285;5301.840944771663;5304.124819404803;5410.377806552247;4863.22188449849;4874.53691899269;4895.192293271606;4922.089413458504;4982.57648099912;4748.477667456577;5019.046381187581;5024.095662780698;5045.545900868921;5093.974530127344;4849.927251091254;4894.1924582444035;4938.753062346868;4957.950420495785;4959.057779021974;4931.580815630676;4948.925766113512;4957.652964292501;4968.90062198754;4989.501049895018;4734.337192793012;4828.806847726087;4914.827981020647;4946.629002824767;4978.029284289565;5107.846764597068;5225.634205605609;5233.869153271199;5234.7644356004075;5247.86880327991;5819.9418005819825;5840.795572154997;5844.064949608042;5850.268716410449;5851.473367396912;5755.3381361143165;5844.649321040752;5867.823965281048;5867.8533036674;5873.765049398019;5324.520793128599;5335.253064570924;5402.351717793811;5416.160495123262;5452.672839629595;5892.587518873637;5894.115882617556;5925.585209035326;5926.614770039933;5966.582339236212;5528.530074943595;5584.329880414376;5706.743196556165;5712.457316554921;5718.342390625048;5666.065099258659;5784.1902133701315;5913.408659134052;5913.526917846562;5973.731182096729;5604.551635869202;5606;5606.018946684314;5612.494875461228;5621.437856214346;5551.417101204396;5664.660120392789;5668.603197776116;5692.6299790513485;5693.146028095819;4394.912101757947;4449.377087207794;4453.977730111394;4491.550844915548;4491.910161796745;3995.900102497461;4002.0595160137927;4021.235965166609;4027.4562934003534;4028.133951200506;5306.548943339782;5399.4600539945695;5424.945750542523;5476.644018138888;5510.035743744828;5755.280589926259;5782.595218334676;5782.65304081748;5792.1311803229855;5839.386864379179;5378.489043540857;5465.508104270555;5475.972620136953;5477.67133971963;5482.753276102585;4850.078485087822;4940.135476291634;4975.328330675313;5048.192289233705;5077.365329333833;5889.381614930457;5911.586188966731;5913.083472061838;5919.319278283053;5923.881522369528;5736.168255602831;5788.0739081746715;5802.506786923159;5804.883902322014;5805.129230615442;5729.427057294404;5734.168545560787;5791.913121303268;5920.437558431942;5923.496502797138;5705.22979397776;5709.286339207599;5713.8285851424525;5714.485696287354;5723;5747.655140691572;5783.508401785895;5789.1605717171615;5799.652020878761;5803.709814509173;5394.002109609734;5484.698341591251;5540.944590554204;5605.467480589337;5639.464250896158;5640.71796410186;5640.746166422603;5644.322681278273;5646.604737668324;5647.943520564741;5363.436839131991;5542.334919809648;5546.306711661043;5549.056660367666;5550.333959924674;5636.661800291996;5667.631603945731;5751.8562035949435;5791.623544469596;5809.36097029318;5558.749856256397;5576.275084239185;5576.91634625489;5579.804706835242;5583.302087239095 20:00:00 INFO - 2015-11-20 20:00:00,015 DEBUG : BROWSER_OUTPUT: |1;ext.html;584.6258394627442;594.8839976204639;597.2772944736867;599.8680290336124;604.6734763227857;31060;31958.20104497386;31974.84012579937;32115.839420802862;40323.79838100813;43229.35155972655;43598.782006089925;43610;43679.56320436794;43747.34378984318;8596.785080372978;8735.432196907212;8741.25699315559;8751.781205469882;8762.43044202128;7755.457118001742;7930.048394192705;8620.741377758677;10365.844512332284;10621.681349559525;10254.692359229235;10362.844557331608;10364.11904988077;10364.378137311747;10365.274430789848;7760;10224.693259202237;10283.177345812355;10331;10333.22500812442;7630.961845190794;10266.281360304782;10456.477176141163;10598.841017384746;10604.628837990633;39564.417423303035;40317;40349;40367.59632403668;40382.596174038474;3360.4959256111533;3409.8465569049454;3693.9630603693886;3978.1049263915675;4006.0897340219067;30174.245643859078;30195.245118871986;30538.08385748431;30664.540031899316;30842.383152337054;3934.626210509997;3950.308695978221;3960.980195099035;4020.8994775130564;4022.2960981828064;275656.6217168921;275762;276299;276674;277464;55360.72319638376;56101;58922.70538647279;59470.405295947356;63972;59900.70049649724;59948.70025649931;59956.70021649864;60157;60265;16234.107124108288;16433.67132657364;16448.917755411145;16495.91752041232;16509.58726031859;11787.528498860122;11808.291502509877;11824.822627660593;11825.704357391134;11826.763464730657;19231.97718763844;19544.609107818047;19572.314968976018;19578.118984645724;19632.803671963382;7068.974998625171;7152.892706609405;7158.2483839197175;7190.96404517974;7333.413326933833;950.5009869818263;977.4379731654327;1014.4319181258519;1018.221060888421;1031.9174466042698;25753.48493030129;25802.741972580036;25943.351416214744;26039;26062.218133456026;998.9950050249702;1075.1560025380038;1084.3006260961793;1102.8841971592867;1115.219346457483;13914.51299204523;14139.151650900978;15214.847851521565;15459.536213913601;15608.687826243638;318130;323588.43852026714;323610;324233;324246;51797;52317.47682523202;52332.73833630807;52358.476415236124;52462.475375246526;1319.399673148715;1319.7756381415184;1324.4569726412126;1327.515456858259;1333.8132661427408;27881.86059069773;28849.85575072111;29104.689720511436;29195.562066569444;29477.557836632895;45736;46350.53649463462;46383.76808115938;46392.76803615961;46458.53541464542;299487;302167;389779;400271;420924;30121.69878301189;30132.548011779403;30138.3972320548;30371.39257214799;30574.08277751671;41530;42249.78875105605;42514;43431;43548.12903741844;34210.65789342174;34914.65085349114;34943.65056349404;35293.47059794157;35310.29379412346;32172.83913580417;32617.34765304728;32735.34529309448;32876.67123328736;32918.341633166725;32993.34013319672;33240.33519329648;33324.66675333216;33562.83218583892;35716.64283357237;30505.389892201587;32059;32164;32782.83608581942;32793.83603081969;23424.53150937006;24738.876305618356;24757.752422475543;24891.626625600267;25053 20:00:00 INFO - 2015-11-20 20:00:00,016 DEBUG : BROWSER_OUTPUT: |2;jquery.html;340.6048983179512;341.5321010216004;341.78979927344693;342.16170382562717;343.4556228378021;13831.515896943609;14247.572572822832;15947.601309967256;16013.359465621375;16830.57923551912;16029.839701602981;16431.67136657266;16630.916845415788;16695.248713807876;16784.832151678478;4680.906381872361;5363.758630861621;5364.1149210380245;5365.517103460687;5370.167624018264;4041.4746083009313;4157.5634558371385;5319.893602127955;5815.418458154193;6006.519478441714;5741.942580574183;5842.941570584282;5909.970450147744;5945.64326140433;5957.046872500401;5850.180974663551;5852.0344143216535;5874.97062514689;5877.177195192677;5878.441548052928;5147.510986456281;5154.123798954187;5160.045391602565;5163.63854530183;6055.515558755289;20499.18003279867;20609.8969505153;20963.371098867057;21138.78861211399;21608.35174944754;2176.8258539316816;2195.967060494094;2263.6604509323734;2317.6523521471913;2412.1798588479824;14173.433062677585;14429.927850360786;14685.486007989775;14712.55862324132;14714.779278310834;1948.133080779054;1954.208545539059;1955.1788248935338;1976.170008596393;2013.8690985086068;66977.66511167462;68505.65747171282;70532;71156;71338.64330678365;14825.184614846286;15457;15460.149691766836;15460.149691767061;15508.612284692974;24170.637440438408;24279;24336.634950475756;24498.265052048468;24562;9374.484403357745;9530.52347382628;9536.141747242782;9598.184154346958;9604.327697061139;8164.428490005761;8208.58957052145;8223.301019413297;8258.669653213925;8260.091389947102;7684.769456916301;7694.269044440769;7720.8455830884195;7790.259925307087;7858.292753652198;2592.468543948486;2997.250687328168;3007.1880592239972;3038.3771326877936;3050.450918834587;896.0233345653269;974.4932635029745;1024.8616436781087;1032.3031953431405;1046.947652617366;13150.145240559525;15322.540323790305;15338.616534586725;15818.92090539563;15967.68064638724;923.4505469245788;941.0448394879203;947.3321308477507;968.6803354892868;996.257787947969;9242.260619150451;9761.121499064977;9774.902250977542;9778.853317200248;9801.950990245003;489461;498081;504737;506001;507158;71336.286637134;74655.25344746592;76026.23973760303;76317.61841190759;76414.61792691001;487.5952959043985;496.4340651657114;496.4960565026501;496.63497329462814;496.69949680443534;9984.60061597528;10439.269251152346;10456.424896630455;10466.476676166008;10520.263581549218;35488.29023419569;35541.28917421585;35574.466383004794;36411.81794091118;36870.446943295334;46005;47816.282755759385;48444.51555484541;48975.510244897094;49162.508374917226;8765.868511972452;9170.67902623405;9305.767355816159;9601.90398096038;9630.374025688308;16363.672468401826;16580.668386632442;16615.252313646157;17568.472945811645;17885.142202520194;14732.631684207552;14830.629234268798;14969.251537422868;15091.698166036836;15354.769678455055;14318.498852540111;14327.497055241687;14785.852141478448;14841.777373339193;14932.552023439313;13910.095843770123;13984.44062237499;14248.643783905485;14695.632609184428;14826.40694372213;9638.518074096408;9669.564869580745;9779.315447918862;9803.676503672199;9804.509774511389;12758.744825103631;14011.08927919682;14028.509002184874;14112.012159149172;14839.33223004989 20:00:00 INFO - 2015-11-20 20:00:00,016 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1311.0494891203873;1407.9155250684958;1410.8165938428006;1500.4298366620683;1722.3369002933875;6631.13795206623;6986.441084713223;7185.281471852819;7191.784246472601;7201.423886089114;7250.782476525713;7332.0834895638045;7344.48588598797;7351.044364232655;7351.191368949411;2230.944226394337;2247.0786977339294;2252.9887350563226;2253;2255.9887200563976;2270.5345404192103;2294.6558016297604;2306.630939049752;2308.284431826139;2308.9538209235807;2222.6110430674566;2227.24273746926;2229.5429436965383;2251.3808702606834;2262.7850354216407;2236.463248820288;2259.367377134405;2260.8530445520987;2261.999999999992;2267.7958983691465;2255.774422557731;2263.818894488437;2264.07173059045;2266.1275408967504;2266.354089084603;6285.685715714196;6492.967535162341;7252.9637351813435;7301.744438944665;7313.122425308944;4431.158079964796;4566.634669226454;4574.679772415932;4580.793864276082;4587.9082418351445;2979.0467050543834;3001.474741920177;3006.5339872319823;3036.316828713544;3213.7107660310685;994.9602015919354;1009.1825621246813;1017.9694609161663;1022.6676330192718;1050.6847945616285;10111.848322275171;10173.440460774655;10187.847182292271;10196.796064078677;10197.082262596328;4103.2409004334295;4183.874483765492;4189.853355132555;4190.350495673176;4236.830526778956;8745.300375969908;8753.518556479456;8757.649694012169;8765.912340876637;8779.25376343018;4639.628829693616;4646.767661616906;4650.302454631765;4654.790534425959;4655.371524844103;4243.045314804206;4243.384709217146;4243.511996120424;4252.851150209728;4253.532111467736;3428.8457019434186;3487.2502411981545;3495.790252584853;3495.9825200873834;3516.9648303517147;1126.14975693351;1136.8749437561862;1138.772245550893;1143.7255058785831;1150.0856818829052;1024.8513965475113;1035.6582327831798;1044.8537204791335;1072.522727386321;1074.8011617850566;7072.929270707227;7162.176349719849;7162.856742865113;7163.570185788869;7172.856542869114;473.486267399875;475.2040332443144;477.11971412743435;477.34365247784297;477.8255936583192;5276.551493123127;5604.075327570905;5626.212330273765;5635.239242702182;5693.28833895763;8212.753617391489;8596.140385961478;8855.601497932608;8937.73186804397;8939.821203576023;8464.153584641486;8791.780205494786;8809.42738721994;8823.073577274423;8825.426347287406;6622.9006564901565;6676.933230667728;6709.731610735614;6713.328667133248;6713.395794378529;6604.768833090819;6688.063671085954;6689.397954184147;6706.932930670826;6711.362420570038;7572.356349710336;7768.650410731418;7795.922040779519;7859.449838511249;7878.763637090897;7873.448858579844;7915.564643944638;7954.363650908029;7958.283754461894;7988.121306656147;6400.967995159995;6512.706928188148;6550.737970481318;6553.901691474536;6555.967220163869;7093.751718689821;7125.608091555015;7140.214576396488;7141.285871412817;7142.107236595426;6353.904691429725;6488.772892948724;6517.608943463408;6544.869102617826;6641.169853768279;6498.122753428227;6547.1161393213215;6633.6019838809825;6704.66476676174;6723.798286051427;6577.276499585138;6611.570247933869;6613.107230523818;6635.402813746786;6655.500837437308;6067.423594758491;6161.291451483136;6174.6912654368;6199.969000154971;6205.379462053758;6171.537134714825;6249.1563638908165;6250.531210159165;6254.530910181664;6261.092141639528 20:00:00 INFO - 2015-11-20 20:00:00,018 DEBUG : BROWSER_OUTPUT: |4;prototype.html;325.27950589444384;329.1622819923295;330.50094357520135;332.3684998502845;335.11529561956456;5853.473187413132;6062.66655333957;6098.603590766608;6125;6131.785387511432;5832.329282132556;6005.099235114735;6013.067974463965;6014.218151640281;6030.155778191057;4644.4891061983235;4652.209124448852;4659.88350291242;4660.86017419478;4661.790219440133;4455.331700244973;4510.278355463127;4549.499555048942;4587.816487340519;4652.8138874444985;4575.862724118265;4578.061497393026;4609.516000819916;4609.746463944482;4610.469795973456;4597.126545956275;4598.977005114986;4608.7004344717825;4614.769261536927;4616.8153273869;4028.6978476614076;4034.0721634024044;4035.7982100895133;4040.373742069984;4047.736897101679;5619.971900140514;5682.914756278659;5701.543876489871;5706.80026199081;5709.229254050733;5342.091844386464;5352.437994010651;5354.839354819323;5355.544778693816;5355.866103347408;6037.78867739627;6315.526335524854;6334.936650633527;6342.841428964267;6348.0477928310665;4355.368471571636;4374.518802931675;4458;4459.910801783979;4470.9105817883465;6678.365555272241;6681.699323530502;6693.1298931138645;6698.430633396167;6711.959646254838;4565.748883811356;4569.908601827945;4573.428321459817;4575.10785396851;4576.244919588231;4389.692721509464;4527.162474942146;4532.501424843264;4614.976925115353;4617.976910115495;5250.159974404077;5252.2384254282915;5257.2902658140665;5269.499397557226;5274.393444753902;6374.330695277022;6421.711023003976;6432.131662225634;6439.935600643934;6443.387878151568;1571.363597742916;1601.7277062899336;1603.559021269137;1604.334201306468;1604.3823128095767;1054.3199636234585;1064.771074219031;1073.6778966310076;1084.5878566144816;1092.4974511724536;6218.22272215973;6219.875602487925;6227.844303892349;6228.439440450381;6228.813135605939;6625.17185351831;6628.105205797156;6630.204375474877;6630.701618427182;6632.767853125118;6080.270367555921;6207.906881396782;6218.036204388237;6225.844353891099;6230.59501132425;3561.28774245152;3586.605473397924;3586.802725850051;3591.2996965591983;3597.172650290448;6680.632565208863;6724.125863637696;6725.092112564741;6751.932480675228;6754.425873800782;6652.035454859115;6722.731090756412;6724.462043036546;6747.122874026345;6786.830329241809;6716.932830671729;6743.325667433218;6750.797476075725;6757.831054223684;6758.459323254128;6418.229812422539;6483.935160648333;6574.638394888136;6597.868042639025;6608.8347791305605;6539.313372095861;6554.8361290968105;6594.076829243813;6616.2722100567935;6621.966890165711;6795.354441328066;6797.660116994031;6798.76204332846;6799.93200067993;6806.719748884179;4413.0953154602585;4414.161309351213;4462.174497717932;4484.618807401277;4486.7756612168605;6600.405963463311;6614.470842332698;6617.636030018395;6619.139511863427;6619.238787539494;6439.291677915519;6449.451796597342;6451.935480645134;6452.161219041494;6453.290138084713;6239.937600623935;6432.2602900667025;6436.8390790230615;6476.676166191766;6477.578957367756;6347.936520634919;6348.269948955929;6359.96820015897;6360;6381.3937675920715;6462.4183823456115;6508.707108180049;6516.869662606816;6521.869562608626;6527.934720652733;6187.133801267736;6317.241930968313;6332.588381755171;6334.809955701337;6339.302676705466 20:00:00 INFO - 2015-11-20 20:00:00,019 DEBUG : BROWSER_OUTPUT: |5;yui.html;794.3962588432793;804.7706403674954;850.0822740446519;860.8063185783197;870.8171284030354;13405.262710550916;13619.591412257623;13673.384697688603;13677.110987785787;13683.110597811148;13295.601131966032;13363.599092027254;13367.331633418338;13372.063955523094;13384.196948183117;680.4760334542424;685.5132855672454;810.6352141536318;819.4796304346723;835.4611275727152;821.4250024982506;829.3365307753803;830.0205757206494;831.4969443486664;833.4957350802767;867.6702852915914;868.0278088540844;870.29071306885;870.5908223135116;875.6278581602825;865.3553102938288;866.6273502393968;868.288003836854;868.3791089371099;869.2003356911625;513.8561202863167;514.1182871375571;618.6937465954381;625.5964902637774;626.0702856258453;13320.400581973834;13438.52965146225;13455.32723363828;13491;13508.864911350858;11860.822087668606;12408.255504669749;12584.68538286541;12671.429785659668;12863.392075990501;10189.694309170736;10323.535440905178;10405.11556517697;10547.84178237327;10684.51919663617;3560.6795388415167;3597.460380942853;3597.7121830253777;3612.4942508048894;3693.815309234554;47003.529964700596;47151.05697886057;47189.292160617275;47292.05415891697;47374;9782.706518804447;9846.458444785463;9977.850332245021;10135.898641013495;10444.582216711398;18118;18145.364912228008;18150.183241754152;18151.27394904189;18157.909210453865;7643.617819109022;7663.540187588763;7865.331446827084;7897.960510197412;7899.368050555941;4194.203101410722;4198.916021679549;4257.148570285955;4309.439772829513;4311.590398912098;3012.894548690829;3045.74111200546;3046.9847650761603;3057.0828751374497;3061.7550595952716;529.8410476856927;541.4098632490526;545.1495666759868;550.7906995341824;554.7281831902338;594.9970250148722;632.5167037861916;660.7158921663731;663.3565441521716;682.3688088518101;8499.660013599387;8913.153250441197;9397.812043759086;9533.189678877234;9556.904430955601;516.6770768269831;672.7947975867407;681.2268075734078;691.6334342798325;692.3111504053498;4210.610021569938;4316.287812510964;4329.242382583036;4368.694191406635;4394.978025109854;58842.70578647165;60045.69977150086;60146;60211.397886021456;60372.09441858376;53226;53231.46768532265;53722;54123.458765411844;54381;43930.780346098065;46120;47735.761321193866;47993.28010079852;49204;8565.528895910784;8770.166834150745;8948.910510894808;9014.549272536478;9043.638254469748;36025;36912;37290.254194915404;37433.81283093567;37590.812045939594;47016.529834701214;47116;47497.52502474931;47618.761906191634;47682.28476572924;10772.89227107719;10906.61826836057;11254.493547790205;11315.151363647594;11339.71650708706;12046.009062391147;12340.259584424963;12370.690732731753;12415.068869834618;12762.68093297675;11096.833547496955;11340.036096931854;11710.355930423908;11909.40452977365;11936.820947685617;11164.497597607964;11566.479508421973;11568.363739994382;11726.179167458196;11902.166848320534;7531.815908351151;10960.232783705063;11395.658130256106;11499.827502587636;11664;9399.295052870926;9980.60077596888;9997.300188986992;10099.091081802673;10226.744331391776;9612.471314077793;9969;10042.548085336324;10043.748906277402;10060.496975151067 20:00:00 INFO - 2015-11-20 20:00:00,019 DEBUG : BROWSER_OUTPUT: __end_tp_report 20:00:00 INFO - 2015-11-20 20:00:00,019 DEBUG : BROWSER_OUTPUT: __start_cc_report 20:00:00 INFO - 2015-11-20 20:00:00,019 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,1004 20:00:00 INFO - 2015-11-20 20:00:00,019 DEBUG : BROWSER_OUTPUT: __end_cc_report 20:00:00 INFO - 2015-11-20 20:00:00,019 DEBUG : BROWSER_OUTPUT: __startTimestamp1448078400012__endTimestamp 20:00:00 INFO - 2015-11-20 20:00:00,019 DEBUG : BROWSER_OUTPUT: 20:00:00 INFO - 2015-11-20 20:00:00,019 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 20:00:00 INFO - 2015-11-20 20:00:00,019 DEBUG : BROWSER_OUTPUT: Number of tests: 6 20:00:00 INFO - 2015-11-20 20:00:00,019 DEBUG : BROWSER_OUTPUT: 20:00:00 INFO - 2015-11-20 20:00:00,019 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:5351.80 Median:5549.06 stddev:580.46 (10.5%) stddev-sans-first:556.37 20:00:00 INFO - 2015-11-20 20:00:00,020 DEBUG : BROWSER_OUTPUT: Values: 3167.1 3235.8 3277.7 3289.5 3301.1 5123.2 5212.1 5266.0 5375.1 5484.7 5271.4 5285.0 5301.8 5304.1 5410.4 4863.2 4874.5 4895.2 4922.1 4982.6 4748.5 5019.0 5024.1 5045.5 5094.0 4849.9 4894.2 4938.8 4958.0 4959.1 4931.6 4948.9 4957.7 4968.9 4989.5 4734.3 4828.8 4914.8 4946.6 4978.0 5107.8 5225.6 5233.9 5234.8 5247.9 5819.9 5840.8 5844.1 5850.3 5851.5 5755.3 5844.6 5867.8 5867.9 5873.8 5324.5 5335.3 5402.4 5416.2 5452.7 5892.6 5894.1 5925.6 5926.6 5966.6 5528.5 5584.3 5706.7 5712.5 5718.3 5666.1 5784.2 5913.4 5913.5 5973.7 5604.6 5606.0 5606.0 5612.5 5621.4 5551.4 5664.7 5668.6 5692.6 5693.1 4394.9 4449.4 4454.0 4491.6 4491.9 3995.9 4002.1 4021.2 4027.5 4028.1 5306.5 5399.5 5424.9 5476.6 5510.0 5755.3 5782.6 5782.7 5792.1 5839.4 5378.5 5465.5 5476.0 5477.7 5482.8 4850.1 4940.1 4975.3 5048.2 5077.4 5889.4 5911.6 5913.1 5919.3 5923.9 5736.2 5788.1 5802.5 5804.9 5805.1 5729.4 5734.2 5791.9 5920.4 5923.5 5705.2 5709.3 5713.8 5714.5 5723.0 5747.7 5783.5 5789.2 5799.7 5803.7 5394.0 5484.7 5540.9 5605.5 5639.5 5640.7 5640.7 5644.3 5646.6 5647.9 5363.4 5542.3 5546.3 5549.1 5550.3 5636.7 5667.6 5751.9 5791.6 5809.4 5558.7 5576.3 5576.9 5579.8 5583.3 20:00:00 INFO - 2015-11-20 20:00:00,020 DEBUG : BROWSER_OUTPUT: 20:00:00 INFO - 2015-11-20 20:00:00,020 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:48381.91 Median:324239.50 stddev:85013.57 (26.2%) stddev-sans-first:85176.31 20:00:00 INFO - 2015-11-20 20:00:00,021 DEBUG : BROWSER_OUTPUT: Values: 584.6 594.9 597.3 599.9 604.7 31060.0 31958.2 31974.8 32115.8 40323.8 43229.4 43598.8 43610.0 43679.6 43747.3 8596.8 8735.4 8741.3 8751.8 8762.4 7755.5 7930.0 8620.7 10365.8 10621.7 10254.7 10362.8 10364.1 10364.4 10365.3 7760.0 10224.7 10283.2 10331.0 10333.2 7631.0 10266.3 10456.5 10598.8 10604.6 39564.4 40317.0 40349.0 40367.6 40382.6 3360.5 3409.8 3694.0 3978.1 4006.1 30174.2 30195.2 30538.1 30664.5 30842.4 3934.6 3950.3 3961.0 4020.9 4022.3 275656.6 275762.0 276299.0 276674.0 277464.0 55360.7 56101.0 58922.7 59470.4 63972.0 59900.7 59948.7 59956.7 60157.0 60265.0 16234.1 16433.7 16448.9 16495.9 16509.6 11787.5 11808.3 11824.8 11825.7 11826.8 19232.0 19544.6 19572.3 19578.1 19632.8 7069.0 7152.9 7158.2 7191.0 7333.4 950.5 977.4 1014.4 1018.2 1031.9 25753.5 25802.7 25943.4 26039.0 26062.2 999.0 1075.2 1084.3 1102.9 1115.2 13914.5 14139.2 15214.8 15459.5 15608.7 318130.0 323588.4 323610.0 324233.0 324246.0 51797.0 52317.5 52332.7 52358.5 52462.5 1319.4 1319.8 1324.5 1327.5 1333.8 27881.9 28849.9 29104.7 29195.6 29477.6 45736.0 46350.5 46383.8 46392.8 46458.5 299487.0 302167.0 389779.0 400271.0 420924.0 30121.7 30132.5 30138.4 30371.4 30574.1 41530.0 42249.8 42514.0 43431.0 43548.1 34210.7 34914.7 34943.7 35293.5 35310.3 32172.8 32617.3 32735.3 32876.7 32918.3 32993.3 33240.3 33324.7 33562.8 35716.6 30505.4 32059.0 32164.0 32782.8 32793.8 23424.5 24738.9 24757.8 24891.6 25053.0 20:00:00 INFO - 2015-11-20 20:00:00,021 DEBUG : BROWSER_OUTPUT: 20:00:00 INFO - 2015-11-20 20:00:00,021 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:28579.83 Median:36641.13 stddev:81867.19 (223.4%) stddev-sans-first:82069.39 20:00:00 INFO - 2015-11-20 20:00:00,021 DEBUG : BROWSER_OUTPUT: Values: 340.6 341.5 341.8 342.2 343.5 13831.5 14247.6 15947.6 16013.4 16830.6 16029.8 16431.7 16630.9 16695.2 16784.8 4680.9 5363.8 5364.1 5365.5 5370.2 4041.5 4157.6 5319.9 5815.4 6006.5 5741.9 5842.9 5910.0 5945.6 5957.0 5850.2 5852.0 5875.0 5877.2 5878.4 5147.5 5154.1 5160.0 5163.6 6055.5 20499.2 20609.9 20963.4 21138.8 21608.4 2176.8 2196.0 2263.7 2317.7 2412.2 14173.4 14429.9 14685.5 14712.6 14714.8 1948.1 1954.2 1955.2 1976.2 2013.9 66977.7 68505.7 70532.0 71156.0 71338.6 14825.2 15457.0 15460.1 15460.1 15508.6 24170.6 24279.0 24336.6 24498.3 24562.0 9374.5 9530.5 9536.1 9598.2 9604.3 8164.4 8208.6 8223.3 8258.7 8260.1 7684.8 7694.3 7720.8 7790.3 7858.3 2592.5 2997.3 3007.2 3038.4 3050.5 896.0 974.5 1024.9 1032.3 1046.9 13150.1 15322.5 15338.6 15818.9 15967.7 923.5 941.0 947.3 968.7 996.3 9242.3 9761.1 9774.9 9778.9 9802.0 489461.0 498081.0 504737.0 506001.0 507158.0 71336.3 74655.3 76026.2 76317.6 76414.6 487.6 496.4 496.5 496.6 496.7 9984.6 10439.3 10456.4 10466.5 10520.3 35488.3 35541.3 35574.5 36411.8 36870.4 46005.0 47816.3 48444.5 48975.5 49162.5 8765.9 9170.7 9305.8 9601.9 9630.4 16363.7 16580.7 16615.3 17568.5 17885.1 14732.6 14830.6 14969.3 15091.7 15354.8 14318.5 14327.5 14785.9 14841.8 14932.6 13910.1 13984.4 14248.6 14695.6 14826.4 9638.5 9669.6 9779.3 9803.7 9804.5 12758.7 14011.1 14028.5 14112.0 14839.3 20:00:00 INFO - 2015-11-20 20:00:00,021 DEBUG : BROWSER_OUTPUT: 20:00:00 INFO - 2015-11-20 20:00:00,021 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5163.45 Median:6166.41 stddev:2642.92 (42.9%) stddev-sans-first:2634.47 20:00:00 INFO - 2015-11-20 20:00:00,023 DEBUG : BROWSER_OUTPUT: Values: 1311.0 1407.9 1410.8 1500.4 1722.3 6631.1 6986.4 7185.3 7191.8 7201.4 7250.8 7332.1 7344.5 7351.0 7351.2 2230.9 2247.1 2253.0 2253.0 2256.0 2270.5 2294.7 2306.6 2308.3 2309.0 2222.6 2227.2 2229.5 2251.4 2262.8 2236.5 2259.4 2260.9 2262.0 2267.8 2255.8 2263.8 2264.1 2266.1 2266.4 6285.7 6493.0 7253.0 7301.7 7313.1 4431.2 4566.6 4574.7 4580.8 4587.9 2979.0 3001.5 3006.5 3036.3 3213.7 995.0 1009.2 1018.0 1022.7 1050.7 10111.8 10173.4 10187.8 10196.8 10197.1 4103.2 4183.9 4189.9 4190.4 4236.8 8745.3 8753.5 8757.6 8765.9 8779.3 4639.6 4646.8 4650.3 4654.8 4655.4 4243.0 4243.4 4243.5 4252.9 4253.5 3428.8 3487.3 3495.8 3496.0 3517.0 1126.1 1136.9 1138.8 1143.7 1150.1 1024.9 1035.7 1044.9 1072.5 1074.8 7072.9 7162.2 7162.9 7163.6 7172.9 473.5 475.2 477.1 477.3 477.8 5276.6 5604.1 5626.2 5635.2 5693.3 8212.8 8596.1 8855.6 8937.7 8939.8 8464.2 8791.8 8809.4 8823.1 8825.4 6622.9 6676.9 6709.7 6713.3 6713.4 6604.8 6688.1 6689.4 6706.9 6711.4 7572.4 7768.7 7795.9 7859.4 7878.8 7873.4 7915.6 7954.4 7958.3 7988.1 6401.0 6512.7 6550.7 6553.9 6556.0 7093.8 7125.6 7140.2 7141.3 7142.1 6353.9 6488.8 6517.6 6544.9 6641.2 6498.1 6547.1 6633.6 6704.7 6723.8 6577.3 6611.6 6613.1 6635.4 6655.5 6067.4 6161.3 6174.7 6200.0 6205.4 6171.5 6249.2 6250.5 6254.5 6261.1 20:00:00 INFO - 2015-11-20 20:00:00,023 DEBUG : BROWSER_OUTPUT: 20:00:00 INFO - 2015-11-20 20:00:00,023 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:5348.69 Median:6128.39 stddev:1616.57 (26.4%) stddev-sans-first:1576.52 20:00:00 INFO - 2015-11-20 20:00:00,023 DEBUG : BROWSER_OUTPUT: Values: 325.3 329.2 330.5 332.4 335.1 5853.5 6062.7 6098.6 6125.0 6131.8 5832.3 6005.1 6013.1 6014.2 6030.2 4644.5 4652.2 4659.9 4660.9 4661.8 4455.3 4510.3 4549.5 4587.8 4652.8 4575.9 4578.1 4609.5 4609.7 4610.5 4597.1 4599.0 4608.7 4614.8 4616.8 4028.7 4034.1 4035.8 4040.4 4047.7 5620.0 5682.9 5701.5 5706.8 5709.2 5342.1 5352.4 5354.8 5355.5 5355.9 6037.8 6315.5 6334.9 6342.8 6348.0 4355.4 4374.5 4458.0 4459.9 4470.9 6678.4 6681.7 6693.1 6698.4 6712.0 4565.7 4569.9 4573.4 4575.1 4576.2 4389.7 4527.2 4532.5 4615.0 4618.0 5250.2 5252.2 5257.3 5269.5 5274.4 6374.3 6421.7 6432.1 6439.9 6443.4 1571.4 1601.7 1603.6 1604.3 1604.4 1054.3 1064.8 1073.7 1084.6 1092.5 6218.2 6219.9 6227.8 6228.4 6228.8 6625.2 6628.1 6630.2 6630.7 6632.8 6080.3 6207.9 6218.0 6225.8 6230.6 3561.3 3586.6 3586.8 3591.3 3597.2 6680.6 6724.1 6725.1 6751.9 6754.4 6652.0 6722.7 6724.5 6747.1 6786.8 6716.9 6743.3 6750.8 6757.8 6758.5 6418.2 6483.9 6574.6 6597.9 6608.8 6539.3 6554.8 6594.1 6616.3 6622.0 6795.4 6797.7 6798.8 6799.9 6806.7 4413.1 4414.2 4462.2 4484.6 4486.8 6600.4 6614.5 6617.6 6619.1 6619.2 6439.3 6449.5 6451.9 6452.2 6453.3 6239.9 6432.3 6436.8 6476.7 6477.6 6347.9 6348.3 6360.0 6360.0 6381.4 6462.4 6508.7 6516.9 6521.9 6527.9 6187.1 6317.2 6332.6 6334.8 6339.3 20:00:00 INFO - 2015-11-20 20:00:00,023 DEBUG : BROWSER_OUTPUT: 20:00:00 INFO - 2015-11-20 20:00:00,023 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:14129.22 Median:47133.53 stddev:16491.69 (35.0%) stddev-sans-first:16507.55 20:00:00 INFO - 2015-11-20 20:00:00,024 DEBUG : BROWSER_OUTPUT: Values: 794.4 804.8 850.1 860.8 870.8 13405.3 13619.6 13673.4 13677.1 13683.1 13295.6 13363.6 13367.3 13372.1 13384.2 680.5 685.5 810.6 819.5 835.5 821.4 829.3 830.0 831.5 833.5 867.7 868.0 870.3 870.6 875.6 865.4 866.6 868.3 868.4 869.2 513.9 514.1 618.7 625.6 626.1 13320.4 13438.5 13455.3 13491.0 13508.9 11860.8 12408.3 12584.7 12671.4 12863.4 10189.7 10323.5 10405.1 10547.8 10684.5 3560.7 3597.5 3597.7 3612.5 3693.8 47003.5 47151.1 47189.3 47292.1 47374.0 9782.7 9846.5 9977.9 10135.9 10444.6 18118.0 18145.4 18150.2 18151.3 18157.9 7643.6 7663.5 7865.3 7898.0 7899.4 4194.2 4198.9 4257.1 4309.4 4311.6 3012.9 3045.7 3047.0 3057.1 3061.8 529.8 541.4 545.1 550.8 554.7 595.0 632.5 660.7 663.4 682.4 8499.7 8913.2 9397.8 9533.2 9556.9 516.7 672.8 681.2 691.6 692.3 4210.6 4316.3 4329.2 4368.7 4395.0 58842.7 60045.7 60146.0 60211.4 60372.1 53226.0 53231.5 53722.0 54123.5 54381.0 43930.8 46120.0 47735.8 47993.3 49204.0 8565.5 8770.2 8948.9 9014.5 9043.6 36025.0 36912.0 37290.3 37433.8 37590.8 47016.5 47116.0 47497.5 47618.8 47682.3 10772.9 10906.6 11254.5 11315.2 11339.7 12046.0 12340.3 12370.7 12415.1 12762.7 11096.8 11340.0 11710.4 11909.4 11936.8 11164.5 11566.5 11568.4 11726.2 11902.2 7531.8 10960.2 11395.7 11499.8 11664.0 9399.3 9980.6 9997.3 10099.1 10226.7 9612.5 9969.0 10042.5 10043.7 10060.5 20:00:00 INFO - 2015-11-20 20:00:00,024 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 20:00:00 INFO - 2015-11-20 20:00:00,024 DEBUG : BROWSER_OUTPUT: 20:00:00 INFO - 2015-11-20 20:00:00,737 INFO : Browser exited with error code: 0 20:00:00 INFO - 2015-11-20 20:00:00,753 INFO : Completed test dromaeo_css (00:18:33) 20:00:00 INFO - 2015-11-20 20:00:00,753 INFO : Starting test kraken 20:00:00 INFO - 2015-11-20 20:00:00,754 DEBUG : operating with platform_type : linux_ 20:00:00 INFO - 2015-11-20 20:00:00,754 INFO : Initialising browser for kraken test... 20:00:00 INFO - 2015-11-20 20:00:00,760 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpA06vQI/profile http://localhost:41543/getInfo.html 20:00:04 INFO - 2015-11-20 20:00:04,776 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 20:00:04 INFO - 2015-11-20 20:00:04,776 DEBUG : BROWSER_OUTPUT: colorDepth:24 20:00:04 INFO - 2015-11-20 20:00:04,776 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 20:00:04 INFO - 2015-11-20 20:00:04,776 DEBUG : BROWSER_OUTPUT: __metrics 20:00:04 INFO - 2015-11-20 20:00:04,901 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 20:00:06 INFO - 2015-11-20 20:00:06,229 INFO : Browser initialized. 20:00:06 INFO - 2015-11-20 20:00:06,230 INFO : Running cycle 1/1 for kraken test... 20:00:06 INFO - 2015-11-20 20:00:06,230 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpA06vQI/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 20:00:18 INFO - 2015-11-20 20:00:18,028 DEBUG : BROWSER_OUTPUT: RSS: Main: 141836288 20:00:18 INFO - 2015-11-20 20:00:18,028 DEBUG : BROWSER_OUTPUT: 20:00:20 INFO - 2015-11-20 20:00:20,489 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41543/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:41543/tests/kraken/driver.html?testName=audio-beat-detection) 20:00:21 INFO - 2015-11-20 20:00:21,075 DEBUG : BROWSER_OUTPUT: RSS: Main: 178880512 20:00:21 INFO - 2015-11-20 20:00:21,075 DEBUG : BROWSER_OUTPUT: 20:00:23 INFO - 2015-11-20 20:00:23,660 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41543/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:41543/tests/kraken/driver.html?testName=audio-dft) 20:00:24 INFO - 2015-11-20 20:00:24,229 DEBUG : BROWSER_OUTPUT: RSS: Main: 168132608 20:00:24 INFO - 2015-11-20 20:00:24,229 DEBUG : BROWSER_OUTPUT: 20:00:27 INFO - 2015-11-20 20:00:27,052 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41543/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:41543/tests/kraken/driver.html?testName=audio-fft) 20:00:27 INFO - 2015-11-20 20:00:27,613 DEBUG : BROWSER_OUTPUT: RSS: Main: 151355392 20:00:27 INFO - 2015-11-20 20:00:27,613 DEBUG : BROWSER_OUTPUT: 20:00:29 INFO - 2015-11-20 20:00:29,565 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41543/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:41543/tests/kraken/driver.html?testName=audio-oscillator) 20:00:30 INFO - 2015-11-20 20:00:30,130 DEBUG : BROWSER_OUTPUT: RSS: Main: 155066368 20:00:30 INFO - 2015-11-20 20:00:30,132 DEBUG : BROWSER_OUTPUT: 20:00:32 INFO - 2015-11-20 20:00:32,267 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41543/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:41543/tests/kraken/driver.html?testName=imaging-gaussian-blur) 20:00:32 INFO - 2015-11-20 20:00:32,820 DEBUG : BROWSER_OUTPUT: RSS: Main: 155828224 20:00:32 INFO - 2015-11-20 20:00:32,821 DEBUG : BROWSER_OUTPUT: 20:00:35 INFO - 2015-11-20 20:00:35,692 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41543/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:41543/tests/kraken/driver.html?testName=imaging-darkroom) 20:00:36 INFO - 2015-11-20 20:00:36,266 DEBUG : BROWSER_OUTPUT: RSS: Main: 157286400 20:00:36 INFO - 2015-11-20 20:00:36,266 DEBUG : BROWSER_OUTPUT: 20:00:39 INFO - 2015-11-20 20:00:39,641 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41543/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:41543/tests/kraken/driver.html?testName=imaging-desaturate) 20:00:40 INFO - 2015-11-20 20:00:40,214 DEBUG : BROWSER_OUTPUT: RSS: Main: 156676096 20:00:40 INFO - 2015-11-20 20:00:40,215 DEBUG : BROWSER_OUTPUT: 20:00:42 INFO - 2015-11-20 20:00:42,992 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41543/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:41543/tests/kraken/driver.html?testName=json-parse-financial) 20:00:43 INFO - 2015-11-20 20:00:43,573 DEBUG : BROWSER_OUTPUT: RSS: Main: 156221440 20:00:43 INFO - 2015-11-20 20:00:43,574 DEBUG : BROWSER_OUTPUT: 20:00:45 INFO - 2015-11-20 20:00:45,101 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41543/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:41543/tests/kraken/driver.html?testName=json-stringify-tinderbox) 20:00:45 INFO - 2015-11-20 20:00:45,670 DEBUG : BROWSER_OUTPUT: RSS: Main: 166690816 20:00:45 INFO - 2015-11-20 20:00:45,671 DEBUG : BROWSER_OUTPUT: 20:00:47 INFO - 2015-11-20 20:00:47,481 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41543/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:41543/tests/kraken/driver.html?testName=stanford-crypto-aes) 20:00:48 INFO - 2015-11-20 20:00:48,074 DEBUG : BROWSER_OUTPUT: RSS: Main: 165773312 20:00:48 INFO - 2015-11-20 20:00:48,074 DEBUG : BROWSER_OUTPUT: 20:00:50 INFO - 2015-11-20 20:00:50,118 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41543/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:41543/tests/kraken/driver.html?testName=stanford-crypto-ccm) 20:00:50 INFO - 2015-11-20 20:00:50,699 DEBUG : BROWSER_OUTPUT: RSS: Main: 170250240 20:00:50 INFO - 2015-11-20 20:00:50,699 DEBUG : BROWSER_OUTPUT: 20:00:53 INFO - 2015-11-20 20:00:53,081 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41543/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:41543/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 20:00:53 INFO - 2015-11-20 20:00:53,662 DEBUG : BROWSER_OUTPUT: RSS: Main: 182587392 20:00:53 INFO - 2015-11-20 20:00:53,663 DEBUG : BROWSER_OUTPUT: 20:00:56 INFO - 2015-11-20 20:00:56,169 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41543/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:41543/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 20:00:56 INFO - 2015-11-20 20:00:56,743 DEBUG : BROWSER_OUTPUT: RSS: Main: 181460992 20:00:56 INFO - 2015-11-20 20:00:56,743 DEBUG : BROWSER_OUTPUT: 20:00:58 INFO - 2015-11-20 20:00:58,392 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41543/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:41543/tests/kraken/driver.html?testName=ai-astar) 20:00:58 INFO - 2015-11-20 20:00:58,638 DEBUG : BROWSER_OUTPUT: RSS: Main: 241410048 20:00:58 INFO - 2015-11-20 20:00:58,638 DEBUG : BROWSER_OUTPUT: 20:00:58 INFO - 2015-11-20 20:00:58,642 DEBUG : BROWSER_OUTPUT: __start_tp_report 20:00:58 INFO - 2015-11-20 20:00:58,642 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 20:00:58 INFO - 2015-11-20 20:00:58,642 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 20:00:58 INFO - 2015-11-20 20:00:58,642 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 20:00:58 INFO - 2015-11-20 20:00:58,642 DEBUG : BROWSER_OUTPUT: |0;ai-astar;109;108;103;109;109;109;100;109;113;108 20:00:58 INFO - 2015-11-20 20:00:58,643 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;156;140;156;165;125;151;144;125;166;123 20:00:58 INFO - 2015-11-20 20:00:58,643 DEBUG : BROWSER_OUTPUT: |2;audio-dft;162;162;161;161;162;161;159;162;162;161 20:00:58 INFO - 2015-11-20 20:00:58,643 DEBUG : BROWSER_OUTPUT: |3;audio-fft;72;72;84;96;72;71;71;113;100;71 20:00:58 INFO - 2015-11-20 20:00:58,643 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;91;92;137;90;91;90;135;90;90;134 20:00:58 INFO - 2015-11-20 20:00:58,643 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;109;110;109;110;109;111;110;110;109;109 20:00:58 INFO - 2015-11-20 20:00:58,643 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;145;145;146;144;145;146;147;145;146;147 20:00:58 INFO - 2015-11-20 20:00:58,643 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;96;96;96;95;95;96;95;96;96;96 20:00:58 INFO - 2015-11-20 20:00:58,644 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;59;57;57;63;57;55;56;64;54;56 20:00:58 INFO - 2015-11-20 20:00:58,644 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;68;69;68;69;69;69;69;68;69;69 20:00:58 INFO - 2015-11-20 20:00:58,644 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;85;83;84;84;87;86;86;85;87;85 20:00:58 INFO - 2015-11-20 20:00:58,644 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;118;116;115;121;133;125;123;115;120;116 20:00:58 INFO - 2015-11-20 20:00:58,644 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;142;140;150;143;149;139;148;149;161;138 20:00:58 INFO - 2015-11-20 20:00:58,644 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;66;67;65;67;64;66;69;73;65;66 20:00:58 INFO - 2015-11-20 20:00:58,644 DEBUG : BROWSER_OUTPUT: __end_tp_report 20:00:58 INFO - 2015-11-20 20:00:58,645 DEBUG : BROWSER_OUTPUT: __start_cc_report 20:00:58 INFO - 2015-11-20 20:00:58,645 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,939 20:00:58 INFO - 2015-11-20 20:00:58,645 DEBUG : BROWSER_OUTPUT: __end_cc_report 20:00:58 INFO - 2015-11-20 20:00:58,645 DEBUG : BROWSER_OUTPUT: __startTimestamp1448078458640__endTimestamp 20:00:58 INFO - 2015-11-20 20:00:58,645 DEBUG : BROWSER_OUTPUT: 20:00:58 INFO - 2015-11-20 20:00:58,646 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 20:00:58 INFO - 2015-11-20 20:00:58,646 DEBUG : BROWSER_OUTPUT: Number of tests: 14 20:00:58 INFO - 2015-11-20 20:00:58,646 DEBUG : BROWSER_OUTPUT: 20:00:58 INFO - 2015-11-20 20:00:58,646 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:107.70 Median:109.00 stddev:3.62 (3.3%) stddev-sans-first:3.81 20:00:58 INFO - 2015-11-20 20:00:58,646 DEBUG : BROWSER_OUTPUT: Values: 109.0 108.0 103.0 109.0 109.0 109.0 100.0 109.0 113.0 108.0 20:00:58 INFO - 2015-11-20 20:00:58,646 DEBUG : BROWSER_OUTPUT: 20:00:58 INFO - 2015-11-20 20:00:58,647 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:145.10 Median:153.50 stddev:16.43 (10.7%) stddev-sans-first:16.94 20:00:58 INFO - 2015-11-20 20:00:58,647 DEBUG : BROWSER_OUTPUT: Values: 156.0 140.0 156.0 165.0 125.0 151.0 144.0 125.0 166.0 123.0 20:00:58 INFO - 2015-11-20 20:00:58,647 DEBUG : BROWSER_OUTPUT: 20:00:58 INFO - 2015-11-20 20:00:58,647 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:161.30 Median:162.00 stddev:0.95 (0.6%) stddev-sans-first:0.97 20:00:58 INFO - 2015-11-20 20:00:58,647 DEBUG : BROWSER_OUTPUT: Values: 162.0 162.0 161.0 161.0 162.0 161.0 159.0 162.0 162.0 161.0 20:00:58 INFO - 2015-11-20 20:00:58,647 DEBUG : BROWSER_OUTPUT: 20:00:58 INFO - 2015-11-20 20:00:58,647 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:82.20 Median:72.00 stddev:15.45 (21.5%) stddev-sans-first:15.94 20:00:58 INFO - 2015-11-20 20:00:58,647 DEBUG : BROWSER_OUTPUT: Values: 72.0 72.0 84.0 96.0 72.0 71.0 71.0 113.0 100.0 71.0 20:00:58 INFO - 2015-11-20 20:00:58,647 DEBUG : BROWSER_OUTPUT: 20:00:58 INFO - 2015-11-20 20:00:58,647 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:104.00 Median:90.00 stddev:21.64 (24.0%) stddev-sans-first:22.44 20:00:58 INFO - 2015-11-20 20:00:58,647 DEBUG : BROWSER_OUTPUT: Values: 91.0 92.0 137.0 90.0 91.0 90.0 135.0 90.0 90.0 134.0 20:00:58 INFO - 2015-11-20 20:00:58,647 DEBUG : BROWSER_OUTPUT: 20:00:58 INFO - 2015-11-20 20:00:58,648 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:109.60 Median:110.00 stddev:0.70 (0.6%) stddev-sans-first:0.71 20:00:58 INFO - 2015-11-20 20:00:58,648 DEBUG : BROWSER_OUTPUT: Values: 109.0 110.0 109.0 110.0 109.0 111.0 110.0 110.0 109.0 109.0 20:00:58 INFO - 2015-11-20 20:00:58,648 DEBUG : BROWSER_OUTPUT: 20:00:58 INFO - 2015-11-20 20:00:58,648 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:145.60 Median:146.00 stddev:0.97 (0.7%) stddev-sans-first:1.00 20:00:58 INFO - 2015-11-20 20:00:58,648 DEBUG : BROWSER_OUTPUT: Values: 145.0 145.0 146.0 144.0 145.0 146.0 147.0 145.0 146.0 147.0 20:00:58 INFO - 2015-11-20 20:00:58,648 DEBUG : BROWSER_OUTPUT: 20:00:58 INFO - 2015-11-20 20:00:58,648 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:95.70 Median:96.00 stddev:0.48 (0.5%) stddev-sans-first:0.50 20:00:58 INFO - 2015-11-20 20:00:58,648 DEBUG : BROWSER_OUTPUT: Values: 96.0 96.0 96.0 95.0 95.0 96.0 95.0 96.0 96.0 96.0 20:00:58 INFO - 2015-11-20 20:00:58,648 DEBUG : BROWSER_OUTPUT: 20:00:58 INFO - 2015-11-20 20:00:58,648 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:57.80 Median:57.00 stddev:3.29 (5.8%) stddev-sans-first:3.46 20:00:58 INFO - 2015-11-20 20:00:58,648 DEBUG : BROWSER_OUTPUT: Values: 59.0 57.0 57.0 63.0 57.0 55.0 56.0 64.0 54.0 56.0 20:00:58 INFO - 2015-11-20 20:00:58,648 DEBUG : BROWSER_OUTPUT: 20:00:58 INFO - 2015-11-20 20:00:58,649 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:68.70 Median:69.00 stddev:0.48 (0.7%) stddev-sans-first:0.44 20:00:58 INFO - 2015-11-20 20:00:58,649 DEBUG : BROWSER_OUTPUT: Values: 68.0 69.0 68.0 69.0 69.0 69.0 69.0 68.0 69.0 69.0 20:00:58 INFO - 2015-11-20 20:00:58,649 DEBUG : BROWSER_OUTPUT: 20:00:58 INFO - 2015-11-20 20:00:58,649 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:85.20 Median:85.50 stddev:1.32 (1.5%) stddev-sans-first:1.39 20:00:58 INFO - 2015-11-20 20:00:58,649 DEBUG : BROWSER_OUTPUT: Values: 85.0 83.0 84.0 84.0 87.0 86.0 86.0 85.0 87.0 85.0 20:00:58 INFO - 2015-11-20 20:00:58,649 DEBUG : BROWSER_OUTPUT: 20:00:58 INFO - 2015-11-20 20:00:58,649 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:120.20 Median:120.50 stddev:5.67 (4.7%) stddev-sans-first:5.96 20:00:58 INFO - 2015-11-20 20:00:58,649 DEBUG : BROWSER_OUTPUT: Values: 118.0 116.0 115.0 121.0 133.0 125.0 123.0 115.0 120.0 116.0 20:00:58 INFO - 2015-11-20 20:00:58,649 DEBUG : BROWSER_OUTPUT: 20:00:58 INFO - 2015-11-20 20:00:58,649 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:145.90 Median:148.50 stddev:6.97 (4.7%) stddev-sans-first:7.25 20:00:58 INFO - 2015-11-20 20:00:58,650 DEBUG : BROWSER_OUTPUT: Values: 142.0 140.0 150.0 143.0 149.0 139.0 148.0 149.0 161.0 138.0 20:00:58 INFO - 2015-11-20 20:00:58,650 DEBUG : BROWSER_OUTPUT: 20:00:58 INFO - 2015-11-20 20:00:58,650 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.80 Median:66.50 stddev:2.57 (3.9%) stddev-sans-first:2.71 20:00:58 INFO - 2015-11-20 20:00:58,650 DEBUG : BROWSER_OUTPUT: Values: 66.0 67.0 65.0 67.0 64.0 66.0 69.0 73.0 65.0 66.0 20:00:58 INFO - 2015-11-20 20:00:58,650 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 20:00:58 INFO - 2015-11-20 20:00:58,650 DEBUG : BROWSER_OUTPUT: 20:00:59 INFO - 2015-11-20 20:00:59,485 INFO : Browser exited with error code: 0 20:00:59 INFO - 2015-11-20 20:00:59,536 INFO : Completed test kraken (00:00:58) 20:00:59 INFO - 2015-11-20 20:00:59,536 INFO : Starting test v8_7 20:00:59 INFO - 2015-11-20 20:00:59,536 DEBUG : operating with platform_type : linux_ 20:00:59 INFO - 2015-11-20 20:00:59,536 INFO : Initialising browser for v8_7 test... 20:00:59 INFO - 2015-11-20 20:00:59,542 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpwJUrzX/profile http://localhost:41543/getInfo.html 20:01:03 INFO - 2015-11-20 20:01:03,398 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 20:01:03 INFO - 2015-11-20 20:01:03,399 DEBUG : BROWSER_OUTPUT: colorDepth:24 20:01:03 INFO - 2015-11-20 20:01:03,399 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 20:01:03 INFO - 2015-11-20 20:01:03,399 DEBUG : BROWSER_OUTPUT: __metrics 20:01:03 INFO - 2015-11-20 20:01:03,556 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 20:01:04 INFO - 2015-11-20 20:01:04,811 INFO : Browser initialized. 20:01:04 INFO - 2015-11-20 20:01:04,812 INFO : Running cycle 1/1 for v8_7 test... 20:01:04 INFO - 2015-11-20 20:01:04,812 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpwJUrzX/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 20:01:16 INFO - 2015-11-20 20:01:16,572 DEBUG : BROWSER_OUTPUT: RSS: Main: 139571200 20:01:16 INFO - 2015-11-20 20:01:16,572 DEBUG : BROWSER_OUTPUT: 20:01:37 INFO - 2015-11-20 20:01:37,989 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41543/tests/v8_7/run.html (next: http://localhost:41543/tests/v8_7/run.html) 20:01:38 INFO - 2015-11-20 20:01:38,247 DEBUG : BROWSER_OUTPUT: RSS: Main: 490475520 20:01:38 INFO - 2015-11-20 20:01:38,247 DEBUG : BROWSER_OUTPUT: 20:01:38 INFO - 2015-11-20 20:01:38,248 DEBUG : BROWSER_OUTPUT: __start_tp_report 20:01:38 INFO - 2015-11-20 20:01:38,248 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 20:01:38 INFO - 2015-11-20 20:01:38,248 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 20:01:38 INFO - 2015-11-20 20:01:38,248 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 20:01:38 INFO - 2015-11-20 20:01:38,248 DEBUG : BROWSER_OUTPUT: |0;Richards;162.94606485253382 20:01:38 INFO - 2015-11-20 20:01:38,248 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;193.98642095053347 20:01:38 INFO - 2015-11-20 20:01:38,248 DEBUG : BROWSER_OUTPUT: |2;Encrypt;285.38812785388126 20:01:38 INFO - 2015-11-20 20:01:38,248 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5060.606060606061 20:01:38 INFO - 2015-11-20 20:01:38,248 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1095.290251916758 20:01:38 INFO - 2015-11-20 20:01:38,248 DEBUG : BROWSER_OUTPUT: |5;Earley;774.5933384972889 20:01:38 INFO - 2015-11-20 20:01:38,248 DEBUG : BROWSER_OUTPUT: |6;Boyer;12048.192771084337 20:01:38 INFO - 2015-11-20 20:01:38,248 DEBUG : BROWSER_OUTPUT: |7;RegExp;26368.42105263158 20:01:38 INFO - 2015-11-20 20:01:38,248 DEBUG : BROWSER_OUTPUT: |8;Splay;671.1409395973154 20:01:38 INFO - 2015-11-20 20:01:38,248 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4835.748792270531 20:01:38 INFO - 2015-11-20 20:01:38,248 DEBUG : BROWSER_OUTPUT: __end_tp_report 20:01:38 INFO - 2015-11-20 20:01:38,249 DEBUG : BROWSER_OUTPUT: __startTimestamp1448078498240__endTimestamp 20:01:38 INFO - 2015-11-20 20:01:38,249 DEBUG : BROWSER_OUTPUT: 20:01:38 INFO - 2015-11-20 20:01:38,249 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 20:01:38 INFO - 2015-11-20 20:01:38,249 DEBUG : BROWSER_OUTPUT: Number of tests: 10 20:01:38 INFO - 2015-11-20 20:01:38,249 DEBUG : BROWSER_OUTPUT: 20:01:38 INFO - 2015-11-20 20:01:38,249 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:162.95 Median:162.95 stddev:0.00 (0.0%) 20:01:38 INFO - 2015-11-20 20:01:38,249 DEBUG : BROWSER_OUTPUT: Values: 162.9 20:01:38 INFO - 2015-11-20 20:01:38,249 DEBUG : BROWSER_OUTPUT: 20:01:38 INFO - 2015-11-20 20:01:38,249 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:193.99 Median:193.99 stddev:0.00 (0.0%) 20:01:38 INFO - 2015-11-20 20:01:38,249 DEBUG : BROWSER_OUTPUT: Values: 194.0 20:01:38 INFO - 2015-11-20 20:01:38,249 DEBUG : BROWSER_OUTPUT: 20:01:38 INFO - 2015-11-20 20:01:38,249 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:285.39 Median:285.39 stddev:0.00 (0.0%) 20:01:38 INFO - 2015-11-20 20:01:38,249 DEBUG : BROWSER_OUTPUT: Values: 285.4 20:01:38 INFO - 2015-11-20 20:01:38,249 DEBUG : BROWSER_OUTPUT: 20:01:38 INFO - 2015-11-20 20:01:38,249 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5060.61 Median:5060.61 stddev:0.00 (0.0%) 20:01:38 INFO - 2015-11-20 20:01:38,249 DEBUG : BROWSER_OUTPUT: Values: 5060.6 20:01:38 INFO - 2015-11-20 20:01:38,250 DEBUG : BROWSER_OUTPUT: 20:01:38 INFO - 2015-11-20 20:01:38,250 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1095.29 Median:1095.29 stddev:0.00 (0.0%) 20:01:38 INFO - 2015-11-20 20:01:38,250 DEBUG : BROWSER_OUTPUT: Values: 1095.3 20:01:38 INFO - 2015-11-20 20:01:38,250 DEBUG : BROWSER_OUTPUT: 20:01:38 INFO - 2015-11-20 20:01:38,250 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:774.59 Median:774.59 stddev:0.00 (0.0%) 20:01:38 INFO - 2015-11-20 20:01:38,250 DEBUG : BROWSER_OUTPUT: Values: 774.6 20:01:38 INFO - 2015-11-20 20:01:38,250 DEBUG : BROWSER_OUTPUT: 20:01:38 INFO - 2015-11-20 20:01:38,250 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:12048.19 Median:12048.19 stddev:0.00 (0.0%) 20:01:38 INFO - 2015-11-20 20:01:38,250 DEBUG : BROWSER_OUTPUT: Values: 12048.2 20:01:38 INFO - 2015-11-20 20:01:38,250 DEBUG : BROWSER_OUTPUT: 20:01:38 INFO - 2015-11-20 20:01:38,250 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:26368.42 Median:26368.42 stddev:0.00 (0.0%) 20:01:38 INFO - 2015-11-20 20:01:38,250 DEBUG : BROWSER_OUTPUT: Values: 26368.4 20:01:38 INFO - 2015-11-20 20:01:38,250 DEBUG : BROWSER_OUTPUT: 20:01:38 INFO - 2015-11-20 20:01:38,250 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:671.14 Median:671.14 stddev:0.00 (0.0%) 20:01:38 INFO - 2015-11-20 20:01:38,250 DEBUG : BROWSER_OUTPUT: Values: 671.1 20:01:38 INFO - 2015-11-20 20:01:38,250 DEBUG : BROWSER_OUTPUT: 20:01:38 INFO - 2015-11-20 20:01:38,251 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4835.75 Median:4835.75 stddev:0.00 (0.0%) 20:01:38 INFO - 2015-11-20 20:01:38,251 DEBUG : BROWSER_OUTPUT: Values: 4835.7 20:01:38 INFO - 2015-11-20 20:01:38,251 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 20:01:38 INFO - 2015-11-20 20:01:38,251 DEBUG : BROWSER_OUTPUT: 20:01:39 INFO - 2015-11-20 20:01:39,117 INFO : Browser exited with error code: 0 20:01:39 INFO - 2015-11-20 20:01:39,136 INFO : Completed test v8_7 (00:00:39) 20:01:39 INFO - 2015-11-20 20:01:39,228 INFO : Completed test suite (00:20:12) 20:01:39 INFO - 2015-11-20 20:01:39,228 DEBUG : Working with test: dromaeo_css 20:01:39 INFO - 2015-11-20 20:01:39,228 DEBUG : Generating results file: dromaeo_css 20:01:39 INFO - 2015-11-20 20:01:39,229 DEBUG : Working with test: kraken 20:01:39 INFO - 2015-11-20 20:01:39,229 DEBUG : Generating results file: kraken 20:01:39 INFO - 2015-11-20 20:01:39,230 INFO : javascript benchmark 20:01:39 INFO - 2015-11-20 20:01:39,230 DEBUG : Working with test: v8_7 20:01:39 INFO - 2015-11-20 20:01:39,230 DEBUG : Generating results file: v8_7 20:01:39 INFO - 2015-11-20 20:01:39,230 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 20:01:39 INFO - 2015-11-20 20:01:39,300 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,64,35]] 20:01:39 INFO - 2015-11-20 20:01:39,300 DEBUG : process_Request line: dromaeo_css 7020.96 graph.html#tests=[[72,64,35]] 20:01:39 INFO - 2015-11-20 20:01:39,300 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 20:01:39 INFO - 2015-11-20 20:01:39,331 DEBUG : process_Request line: kraken 1495.80 graph.html#tests=[[232,64,35]] 20:01:39 INFO - 2015-11-20 20:01:39,331 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 20:01:39 INFO - 2015-11-20 20:01:39,440 DEBUG : process_Request line: v8_7 20861.28 graph.html#tests=[[230,64,35]] 20:01:39 INFO - 2015-11-20 20:01:39,441 INFO : javascript benchmark 20:01:39 INFO - 2015-11-20 20:01:39,445 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3167.144870884861, 3235.7734958552883, 3277.70500654941, 3289.457239555475, 3301.1252018215164, 5123.205903085019, 5212.087884620186, 5265.973670131649, 5375.139977603584, 5484.725763711818, 5271.4464981177, 5285.0, 5301.840944771663, 5304.124819404803, 5410.377806552247, 4863.22188449849, 4874.53691899269, 4895.192293271606, 4922.089413458504, 4982.57648099912, 4748.477667456577, 5019.046381187581, 5024.095662780698, 5045.545900868921, 5093.974530127344, 4849.927251091254, 4894.1924582444035, 4938.753062346868, 4957.950420495785, 4959.057779021974, 4931.580815630676, 4948.925766113512, 4957.652964292501, 4968.90062198754, 4989.501049895018, 4734.337192793012, 4828.806847726087, 4914.827981020647, 4946.629002824767, 4978.029284289565, 5107.846764597068, 5225.634205605609, 5233.869153271199, 5234.7644356004075, 5247.86880327991, 5819.9418005819825, 5840.795572154997, 5844.064949608042, 5850.268716410449, 5851.473367396912, 5755.3381361143165, 5844.649321040752, 5867.823965281048, 5867.8533036674, 5873.765049398019, 5324.520793128599, 5335.253064570924, 5402.351717793811, 5416.160495123262, 5452.672839629595, 5892.587518873637, 5894.115882617556, 5925.585209035326, 5926.614770039933, 5966.582339236212, 5528.530074943595, 5584.329880414376, 5706.743196556165, 5712.457316554921, 5718.342390625048, 5666.065099258659, 5784.1902133701315, 5913.408659134052, 5913.526917846562, 5973.731182096729, 5604.551635869202, 5606.0, 5606.018946684314, 5612.494875461228, 5621.437856214346, 5551.417101204396, 5664.660120392789, 5668.603197776116, 5692.6299790513485, 5693.146028095819, 4394.912101757947, 4449.377087207794, 4453.977730111394, 4491.550844915548, 4491.910161796745, 3995.900102497461, 4002.0595160137927, 4021.235965166609, 4027.4562934003534, 4028.133951200506, 5306.548943339782, 5399.4600539945695, 5424.945750542523, 5476.644018138888, 5510.035743744828, 5755.280589926259, 5782.595218334676, 5782.65304081748, 5792.1311803229855, 5839.386864379179, 5378.489043540857, 5465.508104270555, 5475.972620136953, 5477.67133971963, 5482.753276102585, 4850.078485087822, 4940.135476291634, 4975.328330675313, 5048.192289233705, 5077.365329333833, 5889.381614930457, 5911.586188966731, 5913.083472061838, 5919.319278283053, 5923.881522369528, 5736.168255602831, 5788.0739081746715, 5802.506786923159, 5804.883902322014, 5805.129230615442, 5729.427057294404, 5734.168545560787, 5791.913121303268, 5920.437558431942, 5923.496502797138, 5705.22979397776, 5709.286339207599, 5713.8285851424525, 5714.485696287354, 5723.0, 5747.655140691572, 5783.508401785895, 5789.1605717171615, 5799.652020878761, 5803.709814509173, 5394.002109609734, 5484.698341591251, 5540.944590554204, 5605.467480589337, 5639.464250896158, 5640.71796410186, 5640.746166422603, 5644.322681278273, 5646.604737668324, 5647.943520564741, 5363.436839131991, 5542.334919809648, 5546.306711661043, 5549.056660367666, 5550.333959924674, 5636.661800291996, 5667.631603945731, 5751.8562035949435, 5791.623544469596, 5809.36097029318, 5558.749856256397, 5576.275084239185, 5576.91634625489, 5579.804706835242, 5583.302087239095], "unit": "ms", "name": "dojo.html", "value": 5315.252850550516}, {"lowerIsBetter": false, "replicates": [584.6258394627442, 594.8839976204639, 597.2772944736867, 599.8680290336124, 604.6734763227857, 31060.0, 31958.20104497386, 31974.84012579937, 32115.839420802862, 40323.79838100813, 43229.35155972655, 43598.782006089925, 43610.0, 43679.56320436794, 43747.34378984318, 8596.785080372978, 8735.432196907212, 8741.25699315559, 8751.781205469882, 8762.43044202128, 7755.457118001742, 7930.048394192705, 8620.741377758677, 10365.844512332284, 10621.681349559525, 10254.692359229235, 10362.844557331608, 10364.11904988077, 10364.378137311747, 10365.274430789848, 7760.0, 10224.693259202237, 10283.177345812355, 10331.0, 10333.22500812442, 7630.961845190794, 10266.281360304782, 10456.477176141163, 10598.841017384746, 10604.628837990633, 39564.417423303035, 40317.0, 40349.0, 40367.59632403668, 40382.596174038474, 3360.4959256111533, 3409.8465569049454, 3693.9630603693886, 3978.1049263915675, 4006.0897340219067, 30174.245643859078, 30195.245118871986, 30538.08385748431, 30664.540031899316, 30842.383152337054, 3934.626210509997, 3950.308695978221, 3960.980195099035, 4020.8994775130564, 4022.2960981828064, 275656.6217168921, 275762.0, 276299.0, 276674.0, 277464.0, 55360.72319638376, 56101.0, 58922.70538647279, 59470.405295947356, 63972.0, 59900.70049649724, 59948.70025649931, 59956.70021649864, 60157.0, 60265.0, 16234.107124108288, 16433.67132657364, 16448.917755411145, 16495.91752041232, 16509.58726031859, 11787.528498860122, 11808.291502509877, 11824.822627660593, 11825.704357391134, 11826.763464730657, 19231.97718763844, 19544.609107818047, 19572.314968976018, 19578.118984645724, 19632.803671963382, 7068.974998625171, 7152.892706609405, 7158.2483839197175, 7190.96404517974, 7333.413326933833, 950.5009869818263, 977.4379731654327, 1014.4319181258519, 1018.221060888421, 1031.9174466042698, 25753.48493030129, 25802.741972580036, 25943.351416214744, 26039.0, 26062.218133456026, 998.9950050249702, 1075.1560025380038, 1084.3006260961793, 1102.8841971592867, 1115.219346457483, 13914.51299204523, 14139.151650900978, 15214.847851521565, 15459.536213913601, 15608.687826243638, 318130.0, 323588.43852026714, 323610.0, 324233.0, 324246.0, 51797.0, 52317.47682523202, 52332.73833630807, 52358.476415236124, 52462.475375246526, 1319.399673148715, 1319.7756381415184, 1324.4569726412126, 1327.515456858259, 1333.8132661427408, 27881.86059069773, 28849.85575072111, 29104.689720511436, 29195.562066569444, 29477.557836632895, 45736.0, 46350.53649463462, 46383.76808115938, 46392.76803615961, 46458.53541464542, 299487.0, 302167.0, 389779.0, 400271.0, 420924.0, 30121.69878301189, 30132.548011779403, 30138.3972320548, 30371.39257214799, 30574.08277751671, 41530.0, 42249.78875105605, 42514.0, 43431.0, 43548.12903741844, 34210.65789342174, 34914.65085349114, 34943.65056349404, 35293.47059794157, 35310.29379412346, 32172.83913580417, 32617.34765304728, 32735.34529309448, 32876.67123328736, 32918.341633166725, 32993.34013319672, 33240.33519329648, 33324.66675333216, 33562.83218583892, 35716.64283357237, 30505.389892201587, 32059.0, 32164.0, 32782.83608581942, 32793.83603081969, 23424.53150937006, 24738.876305618356, 24757.752422475543, 24891.626625600267, 25053.0], "unit": "ms", "name": "ext.html", "value": 18672.525629374904}, {"lowerIsBetter": false, "replicates": [340.6048983179512, 341.5321010216004, 341.78979927344693, 342.16170382562717, 343.4556228378021, 13831.515896943609, 14247.572572822832, 15947.601309967256, 16013.359465621375, 16830.57923551912, 16029.839701602981, 16431.67136657266, 16630.916845415788, 16695.248713807876, 16784.832151678478, 4680.906381872361, 5363.758630861621, 5364.1149210380245, 5365.517103460687, 5370.167624018264, 4041.4746083009313, 4157.5634558371385, 5319.893602127955, 5815.418458154193, 6006.519478441714, 5741.942580574183, 5842.941570584282, 5909.970450147744, 5945.64326140433, 5957.046872500401, 5850.180974663551, 5852.0344143216535, 5874.97062514689, 5877.177195192677, 5878.441548052928, 5147.510986456281, 5154.123798954187, 5160.045391602565, 5163.63854530183, 6055.515558755289, 20499.18003279867, 20609.8969505153, 20963.371098867057, 21138.78861211399, 21608.35174944754, 2176.8258539316816, 2195.967060494094, 2263.6604509323734, 2317.6523521471913, 2412.1798588479824, 14173.433062677585, 14429.927850360786, 14685.486007989775, 14712.55862324132, 14714.779278310834, 1948.133080779054, 1954.208545539059, 1955.1788248935338, 1976.170008596393, 2013.8690985086068, 66977.66511167462, 68505.65747171282, 70532.0, 71156.0, 71338.64330678365, 14825.184614846286, 15457.0, 15460.149691766836, 15460.149691767061, 15508.612284692974, 24170.637440438408, 24279.0, 24336.634950475756, 24498.265052048468, 24562.0, 9374.484403357745, 9530.52347382628, 9536.141747242782, 9598.184154346958, 9604.327697061139, 8164.428490005761, 8208.58957052145, 8223.301019413297, 8258.669653213925, 8260.091389947102, 7684.769456916301, 7694.269044440769, 7720.8455830884195, 7790.259925307087, 7858.292753652198, 2592.468543948486, 2997.250687328168, 3007.1880592239972, 3038.3771326877936, 3050.450918834587, 896.0233345653269, 974.4932635029745, 1024.8616436781087, 1032.3031953431405, 1046.947652617366, 13150.145240559525, 15322.540323790305, 15338.616534586725, 15818.92090539563, 15967.68064638724, 923.4505469245788, 941.0448394879203, 947.3321308477507, 968.6803354892868, 996.257787947969, 9242.260619150451, 9761.121499064977, 9774.902250977542, 9778.853317200248, 9801.950990245003, 489461.0, 498081.0, 504737.0, 506001.0, 507158.0, 71336.286637134, 74655.25344746592, 76026.23973760303, 76317.61841190759, 76414.61792691001, 487.5952959043985, 496.4340651657114, 496.4960565026501, 496.63497329462814, 496.69949680443534, 9984.60061597528, 10439.269251152346, 10456.424896630455, 10466.476676166008, 10520.263581549218, 35488.29023419569, 35541.28917421585, 35574.466383004794, 36411.81794091118, 36870.446943295334, 46005.0, 47816.282755759385, 48444.51555484541, 48975.510244897094, 49162.508374917226, 8765.868511972452, 9170.67902623405, 9305.767355816159, 9601.90398096038, 9630.374025688308, 16363.672468401826, 16580.668386632442, 16615.252313646157, 17568.472945811645, 17885.142202520194, 14732.631684207552, 14830.629234268798, 14969.251537422868, 15091.698166036836, 15354.769678455055, 14318.498852540111, 14327.497055241687, 14785.852141478448, 14841.777373339193, 14932.552023439313, 13910.095843770123, 13984.44062237499, 14248.643783905485, 14695.632609184428, 14826.40694372213, 9638.518074096408, 9669.564869580745, 9779.315447918862, 9803.676503672199, 9804.509774511389, 12758.744825103631, 14011.08927919682, 14028.509002184874, 14112.012159149172, 14839.33223004989], "unit": "ms", "name": "jquery.html", "value": 9337.28318409852}, {"lowerIsBetter": false, "replicates": [1311.0494891203873, 1407.9155250684958, 1410.8165938428006, 1500.4298366620683, 1722.3369002933875, 6631.13795206623, 6986.441084713223, 7185.281471852819, 7191.784246472601, 7201.423886089114, 7250.782476525713, 7332.0834895638045, 7344.48588598797, 7351.044364232655, 7351.191368949411, 2230.944226394337, 2247.0786977339294, 2252.9887350563226, 2253.0, 2255.9887200563976, 2270.5345404192103, 2294.6558016297604, 2306.630939049752, 2308.284431826139, 2308.9538209235807, 2222.6110430674566, 2227.24273746926, 2229.5429436965383, 2251.3808702606834, 2262.7850354216407, 2236.463248820288, 2259.367377134405, 2260.8530445520987, 2261.999999999992, 2267.7958983691465, 2255.774422557731, 2263.818894488437, 2264.07173059045, 2266.1275408967504, 2266.354089084603, 6285.685715714196, 6492.967535162341, 7252.9637351813435, 7301.744438944665, 7313.122425308944, 4431.158079964796, 4566.634669226454, 4574.679772415932, 4580.793864276082, 4587.9082418351445, 2979.0467050543834, 3001.474741920177, 3006.5339872319823, 3036.316828713544, 3213.7107660310685, 994.9602015919354, 1009.1825621246813, 1017.9694609161663, 1022.6676330192718, 1050.6847945616285, 10111.848322275171, 10173.440460774655, 10187.847182292271, 10196.796064078677, 10197.082262596328, 4103.2409004334295, 4183.874483765492, 4189.853355132555, 4190.350495673176, 4236.830526778956, 8745.300375969908, 8753.518556479456, 8757.649694012169, 8765.912340876637, 8779.25376343018, 4639.628829693616, 4646.767661616906, 4650.302454631765, 4654.790534425959, 4655.371524844103, 4243.045314804206, 4243.384709217146, 4243.511996120424, 4252.851150209728, 4253.532111467736, 3428.8457019434186, 3487.2502411981545, 3495.790252584853, 3495.9825200873834, 3516.9648303517147, 1126.14975693351, 1136.8749437561862, 1138.772245550893, 1143.7255058785831, 1150.0856818829052, 1024.8513965475113, 1035.6582327831798, 1044.8537204791335, 1072.522727386321, 1074.8011617850566, 7072.929270707227, 7162.176349719849, 7162.856742865113, 7163.570185788869, 7172.856542869114, 473.486267399875, 475.2040332443144, 477.11971412743435, 477.34365247784297, 477.8255936583192, 5276.551493123127, 5604.075327570905, 5626.212330273765, 5635.239242702182, 5693.28833895763, 8212.753617391489, 8596.140385961478, 8855.601497932608, 8937.73186804397, 8939.821203576023, 8464.153584641486, 8791.780205494786, 8809.42738721994, 8823.073577274423, 8825.426347287406, 6622.9006564901565, 6676.933230667728, 6709.731610735614, 6713.328667133248, 6713.395794378529, 6604.768833090819, 6688.063671085954, 6689.397954184147, 6706.932930670826, 6711.362420570038, 7572.356349710336, 7768.650410731418, 7795.922040779519, 7859.449838511249, 7878.763637090897, 7873.448858579844, 7915.564643944638, 7954.363650908029, 7958.283754461894, 7988.121306656147, 6400.967995159995, 6512.706928188148, 6550.737970481318, 6553.901691474536, 6555.967220163869, 7093.751718689821, 7125.608091555015, 7140.214576396488, 7141.285871412817, 7142.107236595426, 6353.904691429725, 6488.772892948724, 6517.608943463408, 6544.869102617826, 6641.169853768279, 6498.122753428227, 6547.1161393213215, 6633.6019838809825, 6704.66476676174, 6723.798286051427, 6577.276499585138, 6611.570247933869, 6613.107230523818, 6635.402813746786, 6655.500837437308, 6067.423594758491, 6161.291451483136, 6174.6912654368, 6199.969000154971, 6205.379462053758, 6171.537134714825, 6249.1563638908165, 6250.531210159165, 6254.530910181664, 6261.092141639528], "unit": "ms", "name": "mootools.html", "value": 4199.969611611908}, {"lowerIsBetter": false, "replicates": [325.27950589444384, 329.1622819923295, 330.50094357520135, 332.3684998502845, 335.11529561956456, 5853.473187413132, 6062.66655333957, 6098.603590766608, 6125.0, 6131.785387511432, 5832.329282132556, 6005.099235114735, 6013.067974463965, 6014.218151640281, 6030.155778191057, 4644.4891061983235, 4652.209124448852, 4659.88350291242, 4660.86017419478, 4661.790219440133, 4455.331700244973, 4510.278355463127, 4549.499555048942, 4587.816487340519, 4652.8138874444985, 4575.862724118265, 4578.061497393026, 4609.516000819916, 4609.746463944482, 4610.469795973456, 4597.126545956275, 4598.977005114986, 4608.7004344717825, 4614.769261536927, 4616.8153273869, 4028.6978476614076, 4034.0721634024044, 4035.7982100895133, 4040.373742069984, 4047.736897101679, 5619.971900140514, 5682.914756278659, 5701.543876489871, 5706.80026199081, 5709.229254050733, 5342.091844386464, 5352.437994010651, 5354.839354819323, 5355.544778693816, 5355.866103347408, 6037.78867739627, 6315.526335524854, 6334.936650633527, 6342.841428964267, 6348.0477928310665, 4355.368471571636, 4374.518802931675, 4458.0, 4459.910801783979, 4470.9105817883465, 6678.365555272241, 6681.699323530502, 6693.1298931138645, 6698.430633396167, 6711.959646254838, 4565.748883811356, 4569.908601827945, 4573.428321459817, 4575.10785396851, 4576.244919588231, 4389.692721509464, 4527.162474942146, 4532.501424843264, 4614.976925115353, 4617.976910115495, 5250.159974404077, 5252.2384254282915, 5257.2902658140665, 5269.499397557226, 5274.393444753902, 6374.330695277022, 6421.711023003976, 6432.131662225634, 6439.935600643934, 6443.387878151568, 1571.363597742916, 1601.7277062899336, 1603.559021269137, 1604.334201306468, 1604.3823128095767, 1054.3199636234585, 1064.771074219031, 1073.6778966310076, 1084.5878566144816, 1092.4974511724536, 6218.22272215973, 6219.875602487925, 6227.844303892349, 6228.439440450381, 6228.813135605939, 6625.17185351831, 6628.105205797156, 6630.204375474877, 6630.701618427182, 6632.767853125118, 6080.270367555921, 6207.906881396782, 6218.036204388237, 6225.844353891099, 6230.59501132425, 3561.28774245152, 3586.605473397924, 3586.802725850051, 3591.2996965591983, 3597.172650290448, 6680.632565208863, 6724.125863637696, 6725.092112564741, 6751.932480675228, 6754.425873800782, 6652.035454859115, 6722.731090756412, 6724.462043036546, 6747.122874026345, 6786.830329241809, 6716.932830671729, 6743.325667433218, 6750.797476075725, 6757.831054223684, 6758.459323254128, 6418.229812422539, 6483.935160648333, 6574.638394888136, 6597.868042639025, 6608.8347791305605, 6539.313372095861, 6554.8361290968105, 6594.076829243813, 6616.2722100567935, 6621.966890165711, 6795.354441328066, 6797.660116994031, 6798.76204332846, 6799.93200067993, 6806.719748884179, 4413.0953154602585, 4414.161309351213, 4462.174497717932, 4484.618807401277, 4486.7756612168605, 6600.405963463311, 6614.470842332698, 6617.636030018395, 6619.139511863427, 6619.238787539494, 6439.291677915519, 6449.451796597342, 6451.935480645134, 6452.161219041494, 6453.290138084713, 6239.937600623935, 6432.2602900667025, 6436.8390790230615, 6476.676166191766, 6477.578957367756, 6347.936520634919, 6348.269948955929, 6359.96820015897, 6360.0, 6381.3937675920715, 6462.4183823456115, 6508.707108180049, 6516.869662606816, 6521.869562608626, 6527.934720652733, 6187.133801267736, 6317.241930968313, 6332.588381755171, 6334.809955701337, 6339.302676705466], "unit": "ms", "name": "prototype.html", "value": 4818.340525746819}, {"lowerIsBetter": false, "replicates": [794.3962588432793, 804.7706403674954, 850.0822740446519, 860.8063185783197, 870.8171284030354, 13405.262710550916, 13619.591412257623, 13673.384697688603, 13677.110987785787, 13683.110597811148, 13295.601131966032, 13363.599092027254, 13367.331633418338, 13372.063955523094, 13384.196948183117, 680.4760334542424, 685.5132855672454, 810.6352141536318, 819.4796304346723, 835.4611275727152, 821.4250024982506, 829.3365307753803, 830.0205757206494, 831.4969443486664, 833.4957350802767, 867.6702852915914, 868.0278088540844, 870.29071306885, 870.5908223135116, 875.6278581602825, 865.3553102938288, 866.6273502393968, 868.288003836854, 868.3791089371099, 869.2003356911625, 513.8561202863167, 514.1182871375571, 618.6937465954381, 625.5964902637774, 626.0702856258453, 13320.400581973834, 13438.52965146225, 13455.32723363828, 13491.0, 13508.864911350858, 11860.822087668606, 12408.255504669749, 12584.68538286541, 12671.429785659668, 12863.392075990501, 10189.694309170736, 10323.535440905178, 10405.11556517697, 10547.84178237327, 10684.51919663617, 3560.6795388415167, 3597.460380942853, 3597.7121830253777, 3612.4942508048894, 3693.815309234554, 47003.529964700596, 47151.05697886057, 47189.292160617275, 47292.05415891697, 47374.0, 9782.706518804447, 9846.458444785463, 9977.850332245021, 10135.898641013495, 10444.582216711398, 18118.0, 18145.364912228008, 18150.183241754152, 18151.27394904189, 18157.909210453865, 7643.617819109022, 7663.540187588763, 7865.331446827084, 7897.960510197412, 7899.368050555941, 4194.203101410722, 4198.916021679549, 4257.148570285955, 4309.439772829513, 4311.590398912098, 3012.894548690829, 3045.74111200546, 3046.9847650761603, 3057.0828751374497, 3061.7550595952716, 529.8410476856927, 541.4098632490526, 545.1495666759868, 550.7906995341824, 554.7281831902338, 594.9970250148722, 632.5167037861916, 660.7158921663731, 663.3565441521716, 682.3688088518101, 8499.660013599387, 8913.153250441197, 9397.812043759086, 9533.189678877234, 9556.904430955601, 516.6770768269831, 672.7947975867407, 681.2268075734078, 691.6334342798325, 692.3111504053498, 4210.610021569938, 4316.287812510964, 4329.242382583036, 4368.694191406635, 4394.978025109854, 58842.70578647165, 60045.69977150086, 60146.0, 60211.397886021456, 60372.09441858376, 53226.0, 53231.46768532265, 53722.0, 54123.458765411844, 54381.0, 43930.780346098065, 46120.0, 47735.761321193866, 47993.28010079852, 49204.0, 8565.528895910784, 8770.166834150745, 8948.910510894808, 9014.549272536478, 9043.638254469748, 36025.0, 36912.0, 37290.254194915404, 37433.81283093567, 37590.812045939594, 47016.529834701214, 47116.0, 47497.52502474931, 47618.761906191634, 47682.28476572924, 10772.89227107719, 10906.61826836057, 11254.493547790205, 11315.151363647594, 11339.71650708706, 12046.009062391147, 12340.259584424963, 12370.690732731753, 12415.068869834618, 12762.68093297675, 11096.833547496955, 11340.036096931854, 11710.355930423908, 11909.40452977365, 11936.820947685617, 11164.497597607964, 11566.479508421973, 11568.363739994382, 11726.179167458196, 11902.166848320534, 7531.815908351151, 10960.232783705063, 11395.658130256106, 11499.827502587636, 11664.0, 9399.295052870926, 9980.60077596888, 9997.300188986992, 10099.091081802673, 10226.744331391776, 9612.471314077793, 9969.0, 10042.548085336324, 10043.748906277402, 10060.496975151067], "unit": "ms", "name": "yui.html", "value": 6386.250025682572}], "name": "dromaeo_css", "value": 7020.959875355128}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [109.0, 108.0, 103.0, 109.0, 109.0, 109.0, 100.0, 109.0, 113.0, 108.0], "unit": "ms", "name": "ai-astar", "value": 107.7}, {"lowerIsBetter": true, "replicates": [156.0, 140.0, 156.0, 165.0, 125.0, 151.0, 144.0, 125.0, 166.0, 123.0], "unit": "ms", "name": "audio-beat-detection", "value": 145.1}, {"lowerIsBetter": true, "replicates": [162.0, 162.0, 161.0, 161.0, 162.0, 161.0, 159.0, 162.0, 162.0, 161.0], "unit": "ms", "name": "audio-dft", "value": 161.3}, {"lowerIsBetter": true, "replicates": [72.0, 72.0, 84.0, 96.0, 72.0, 71.0, 71.0, 113.0, 100.0, 71.0], "unit": "ms", "name": "audio-fft", "value": 82.2}, {"lowerIsBetter": true, "replicates": [91.0, 92.0, 137.0, 90.0, 91.0, 90.0, 135.0, 90.0, 90.0, 134.0], "unit": "ms", "name": "audio-oscillator", "value": 104.0}, {"lowerIsBetter": true, "replicates": [109.0, 110.0, 109.0, 110.0, 109.0, 111.0, 110.0, 110.0, 109.0, 109.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 109.6}, {"lowerIsBetter": true, "replicates": [145.0, 145.0, 146.0, 144.0, 145.0, 146.0, 147.0, 145.0, 146.0, 147.0], "unit": "ms", "name": "imaging-darkroom", "value": 145.6}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 96.0, 95.0, 95.0, 96.0, 95.0, 96.0, 96.0, 96.0], "unit": "ms", "name": "imaging-desaturate", "value": 95.7}, {"lowerIsBetter": true, "replicates": [59.0, 57.0, 57.0, 63.0, 57.0, 55.0, 56.0, 64.0, 54.0, 56.0], "unit": "ms", "name": "json-parse-financial", "value": 57.8}, {"lowerIsBetter": true, "replicates": [68.0, 69.0, 68.0, 69.0, 69.0, 69.0, 69.0, 68.0, 69.0, 69.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 68.7}, {"lowerIsBetter": true, "replicates": [85.0, 83.0, 84.0, 84.0, 87.0, 86.0, 86.0, 85.0, 87.0, 85.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 85.2}, {"lowerIsBetter": true, "replicates": [118.0, 116.0, 115.0, 121.0, 133.0, 125.0, 123.0, 115.0, 120.0, 116.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 120.2}, {"lowerIsBetter": true, "replicates": [142.0, 140.0, 150.0, 143.0, 149.0, 139.0, 148.0, 149.0, 161.0, 138.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 145.9}, {"lowerIsBetter": true, "replicates": [66.0, 67.0, 65.0, 67.0, 64.0, 66.0, 69.0, 73.0, 65.0, 66.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 66.8}], "name": "kraken", "value": 1495.8000000000002}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [162.94606485253382], "unit": "score", "name": "Richards", "value": 216.64837400000005}, {"lowerIsBetter": false, "replicates": [193.98642095053347], "unit": "score", "name": "DeltaBlue", "value": 340.8382899999999}, {"lowerIsBetter": false, "replicates": [285.38812785388126], "unit": "score", "name": "Encrypt", "value": 932.6982240000001}, {"lowerIsBetter": false, "replicates": [5060.606060606061], "unit": "score", "name": "Decrypt", "value": 52.59864071856286}, {"lowerIsBetter": false, "replicates": [1095.290251916758], "unit": "score", "name": "RayTrace", "value": 675.6099569999998}, {"lowerIsBetter": false, "replicates": [774.5933384972889], "unit": "score", "name": "Earley", "value": 860.4037330000002}, {"lowerIsBetter": false, "replicates": [12048.192771084337], "unit": "score", "name": "Boyer", "value": 55.31642899999996}, {"lowerIsBetter": false, "replicates": [26368.42105263158], "unit": "score", "name": "RegExp", "value": 34.54833333333334}, {"lowerIsBetter": false, "replicates": [671.1409395973154], "unit": "score", "name": "Splay", "value": 121.42159000000002}, {"lowerIsBetter": false, "replicates": [4835.748792270531], "unit": "score", "name": "NavierStokes", "value": 306.881118881119}], "name": "v8_7", "value": 20861.27521426044}]} 20:01:39 INFO - RETURN: dromaeo_css: 7020.96 20:01:39 INFO - RETURN: kraken: 1495.80 20:01:39 INFO - RETURN: v8_7: 20861.28 20:01:39 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,64,35]]", "result": "20861.28"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,35]]", "result": "1495.80"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,35]]", "result": "7020.96"}}} 20:01:39 INFO - Return code: 0 20:01:39 INFO - # TBPL SUCCESS # 20:01:39 INFO - Running post-action listener: _resource_record_post_action 20:01:39 INFO - Running post-run listener: _resource_record_post_run 20:01:40 INFO - Total resource usage - Wall time: 1227s; CPU: 13.0%; Read bytes: 4096; Write bytes: 515436544; Read time: 8; Write time: 572188 20:01:40 INFO - install - Wall time: 15s; CPU: 16.0%; Read bytes: 0; Write bytes: 231055360; Read time: 0; Write time: 334728 20:01:40 INFO - run-tests - Wall time: 1213s; CPU: 13.0%; Read bytes: 4096; Write bytes: 264671232; Read time: 8; Write time: 205528 20:01:40 INFO - Running post-run listener: _upload_blobber_files 20:01:40 INFO - Blob upload gear active. 20:01:40 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 20:01:40 INFO - Copying logs to upload dir... 20:01:40 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1262.154388 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 2 secs) (at 2015-11-20 20:01:40.543485) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-20 20:01:40.547509) ========= 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=447a3abc0420b6a47dd38cba000001bf-1448075675.772729-229027168 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/hn4PGcklSIOWRxOdnWaotQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.009856 build_url: 'https://queue.taskcluster.net/v1/task/hn4PGcklSIOWRxOdnWaotQ/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-20 20:01:40.599164) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-20 20:01:40.599492) ========= 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=447a3abc0420b6a47dd38cba000001bf-1448075675.772729-229027168 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004455 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-20 20:01:40.649345) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-20 20:01:40.649677) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-20 20:01:40.649997) ========= ========= Total master_lag: 0.23 =========