builder: mozilla-central_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-001 starttime: 1448074123.61 results: success (0) buildid: 20151120163003 builduid: 5a4cf3a942564e1f8d5138d4fbefba04 revision: 3f5afaf4e6b72c4b1a20749b4ce7d945add5299f ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-11-20 18:48:43.607264) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-11-20 18:48:43.607747) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-20 18:48:43.608112) ========= 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=b4e1481c633df10bed3f4cc0000001c7-1448074121.649156-979618878 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006543 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.01 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-20 18:48:43.628037) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-20 18:48:43.628343) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-20 18:48:43.636193) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-20 18:48:43.636481) ========= 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=b4e1481c633df10bed3f4cc0000001c7-1448074121.649156-979618878 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004390 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-20 18:48:43.685342) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-20 18:48:43.685688) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-20 18:48:43.686125) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-20 18:48:43.686438) ========= 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=b4e1481c633df10bed3f4cc0000001c7-1448074121.649156-979618878 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-11-20 18:48:43-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 222M=0s 2015-11-20 18:48:44 (222 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.108028 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-20 18:48:43.807154) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-20 18:48:43.807514) ========= 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=b4e1481c633df10bed3f4cc0000001c7-1448074121.649156-979618878 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.021292 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-20 18:48:43.857175) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-20 18:48:43.857528) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 3f5afaf4e6b72c4b1a20749b4ce7d945add5299f --destination scripts --debug' in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 3f5afaf4e6b72c4b1a20749b4ce7d945add5299f --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=b4e1481c633df10bed3f4cc0000001c7-1448074121.649156-979618878 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-11-20 18:48:44,192 truncating revision to first 12 chars 2015-11-20 18:48:44,192 Setting DEBUG logging. 2015-11-20 18:48:44,192 attempt 1/10 2015-11-20 18:48:44,192 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/3f5afaf4e6b7?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-11-20 18:48:44,442 unpacking tar archive at: mozilla-central-3f5afaf4e6b7/testing/mozharness/ program finished with exit code 0 elapsedTime=0.524327 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-20 18:48:44.394693) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-20 18:48:44.394998) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-20 18:48:44.402593) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-20 18:48:44.402937) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-20 18:48:44.403389) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 57 secs) (at 2015-11-20 18:48:44.403740) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 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', 'Firefox', '--system-bits', '64', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] 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=b4e1481c633df10bed3f4cc0000001c7-1448074121.649156-979618878 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 18:48:44 INFO - MultiFileLogger online at 20151120 18:48:44 in /builds/slave/test-pgo 18:48:44 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 18:48:44 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 18:48:44 INFO - {'append_to_log': False, 18:48:44 INFO - 'base_work_dir': '/builds/slave/test-pgo', 18:48:44 INFO - 'blob_upload_branch': 'Firefox', 18:48:44 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 18:48:44 INFO - 'branch': 'Firefox', 18:48:44 INFO - 'buildbot_json_path': 'buildprops.json', 18:48:44 INFO - 'config_files': ('talos/linux_config.py',), 18:48:44 INFO - 'default_actions': ('clobber', 18:48:44 INFO - 'read-buildbot-config', 18:48:44 INFO - 'download-and-extract', 18:48:44 INFO - 'populate-webroot', 18:48:44 INFO - 'create-virtualenv', 18:48:44 INFO - 'install', 18:48:44 INFO - 'run-tests'), 18:48:44 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 18:48:44 INFO - 'download_minidump_stackwalk': True, 18:48:44 INFO - 'download_symbols': 'ondemand', 18:48:44 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 18:48:44 INFO - 'tooltool.py': '/tools/tooltool.py', 18:48:44 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 18:48:44 INFO - '/tools/misc-python/virtualenv.py')}, 18:48:44 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 18:48:44 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 18:48:44 INFO - 'installer_path': 'installer.exe', 18:48:44 INFO - 'log_level': 'info', 18:48:44 INFO - 'log_name': 'talos', 18:48:44 INFO - 'log_to_console': True, 18:48:44 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 18:48:44 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 18:48:44 INFO - 'opt_config_files': (), 18:48:44 INFO - 'pip_index': False, 18:48:44 INFO - 'sps_profile': False, 18:48:44 INFO - 'sps_profile_interval': 0, 18:48:44 INFO - 'suite': 'dromaeojs', 18:48:44 INFO - 'system_bits': '64', 18:48:44 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 18:48:44 INFO - 'title': 'talos-linux64-ix-001', 18:48:44 INFO - 'tooltool_cache': '/builds/tooltool_cache', 18:48:44 INFO - 'use_talos_json': True, 18:48:44 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 18:48:44 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 18:48:44 INFO - 'work_dir': 'build'} 18:48:44 INFO - ##### 18:48:44 INFO - ##### Running clobber step. 18:48:44 INFO - ##### 18:48:44 INFO - Running pre-action listener: _resource_record_pre_action 18:48:44 INFO - Running main action method: clobber 18:48:44 INFO - rmtree: /builds/slave/test-pgo/build 18:48:44 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 18:48:45 INFO - Running post-action listener: _resource_record_post_action 18:48:45 INFO - ##### 18:48:45 INFO - ##### Running read-buildbot-config step. 18:48:45 INFO - ##### 18:48:45 INFO - Running pre-action listener: _resource_record_pre_action 18:48:45 INFO - Running main action method: read_buildbot_config 18:48:45 INFO - Using buildbot properties: 18:48:45 INFO - { 18:48:45 INFO - "properties": { 18:48:45 INFO - "buildnumber": 573, 18:48:45 INFO - "product": "firefox", 18:48:45 INFO - "script_repo_revision": "production", 18:48:45 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 18:48:45 INFO - "repository": "", 18:48:45 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs", 18:48:45 INFO - "buildid": "20151120163003", 18:48:45 INFO - "slavename": "talos-linux64-ix-001", 18:48:45 INFO - "pgo_build": "True", 18:48:45 INFO - "basedir": "/builds/slave/test-pgo", 18:48:45 INFO - "project": "", 18:48:45 INFO - "platform": "ubuntu64_hw", 18:48:45 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 18:48:45 INFO - "slavebuilddir": "test", 18:48:45 INFO - "scheduler": "tests-mozilla-central-linux64-pgo-talos", 18:48:45 INFO - "branch": "mozilla-central", 18:48:45 INFO - "repo_path": "mozilla-central", 18:48:45 INFO - "stage_platform": "linux64-pgo", 18:48:45 INFO - "builduid": "5a4cf3a942564e1f8d5138d4fbefba04", 18:48:45 INFO - "revision": "3f5afaf4e6b72c4b1a20749b4ce7d945add5299f" 18:48:45 INFO - }, 18:48:45 INFO - "sourcestamp": { 18:48:45 INFO - "repository": "", 18:48:45 INFO - "hasPatch": false, 18:48:45 INFO - "project": "", 18:48:45 INFO - "branch": "mozilla-central-linux64-pgo-talos", 18:48:45 INFO - "changes": [ 18:48:45 INFO - { 18:48:45 INFO - "category": null, 18:48:45 INFO - "files": [ 18:48:45 INFO - { 18:48:45 INFO - "url": null, 18:48:45 INFO - "name": "https://queue.taskcluster.net/v1/task/hA8dQlKTS3q2OXhD_wXxZg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2" 18:48:45 INFO - } 18:48:45 INFO - ], 18:48:45 INFO - "repository": "", 18:48:45 INFO - "rev": "3f5afaf4e6b72c4b1a20749b4ce7d945add5299f", 18:48:45 INFO - "who": "sendchange", 18:48:45 INFO - "when": 1448074080, 18:48:45 INFO - "number": 6691745, 18:48:45 INFO - "comments": "", 18:48:45 INFO - "project": "", 18:48:45 INFO - "at": "Fri 20 Nov 2015 18:48:00", 18:48:45 INFO - "branch": "mozilla-central-linux64-pgo-talos", 18:48:45 INFO - "revlink": "", 18:48:45 INFO - "properties": [ 18:48:45 INFO - [ 18:48:45 INFO - "buildid", 18:48:45 INFO - "20151120163003", 18:48:45 INFO - "Change" 18:48:45 INFO - ], 18:48:45 INFO - [ 18:48:45 INFO - "builduid", 18:48:45 INFO - "5a4cf3a942564e1f8d5138d4fbefba04", 18:48:45 INFO - "Change" 18:48:45 INFO - ], 18:48:45 INFO - [ 18:48:45 INFO - "pgo_build", 18:48:45 INFO - "True", 18:48:45 INFO - "Change" 18:48:45 INFO - ] 18:48:45 INFO - ], 18:48:45 INFO - "revision": "3f5afaf4e6b72c4b1a20749b4ce7d945add5299f" 18:48:45 INFO - } 18:48:45 INFO - ], 18:48:45 INFO - "revision": "3f5afaf4e6b72c4b1a20749b4ce7d945add5299f" 18:48:45 INFO - } 18:48:45 INFO - } 18:48:45 INFO - Found installer url https://queue.taskcluster.net/v1/task/hA8dQlKTS3q2OXhD_wXxZg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2. 18:48:45 INFO - Running post-action listener: _resource_record_post_action 18:48:45 INFO - ##### 18:48:45 INFO - ##### Running download-and-extract step. 18:48:45 INFO - ##### 18:48:45 INFO - Running pre-action listener: _resource_record_pre_action 18:48:45 INFO - Running main action method: download_and_extract 18:48:45 INFO - mkdir: /builds/slave/test-pgo/build/tests 18:48:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:48:45 INFO - https://queue.taskcluster.net/v1/task/hA8dQlKTS3q2OXhD_wXxZg/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 18:48:45 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/hA8dQlKTS3q2OXhD_wXxZg/artifacts/public/build/test_packages.json 18:48:45 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/hA8dQlKTS3q2OXhD_wXxZg/artifacts/public/build/test_packages.json 18:48:45 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/hA8dQlKTS3q2OXhD_wXxZg/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 18:48:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/hA8dQlKTS3q2OXhD_wXxZg/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 18:48:45 INFO - Downloaded 1302 bytes. 18:48:45 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 18:48:45 INFO - Using the following test package requirements: 18:48:45 INFO - {u'common': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 18:48:45 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 18:48:45 INFO - u'firefox-45.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 18:48:45 INFO - u'jittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 18:48:45 INFO - u'jsshell-linux-x86_64.zip'], 18:48:45 INFO - u'mochitest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 18:48:45 INFO - u'firefox-45.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 18:48:45 INFO - u'mozbase': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 18:48:45 INFO - u'reftest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 18:48:45 INFO - u'firefox-45.0a1.en-US.linux-x86_64.reftest.tests.zip'], 18:48:45 INFO - u'talos': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 18:48:45 INFO - u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'], 18:48:45 INFO - u'web-platform': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 18:48:45 INFO - u'firefox-45.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 18:48:45 INFO - u'webapprt': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 18:48:45 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 18:48:45 INFO - u'firefox-45.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 18:48:45 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 18:48:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:48:45 INFO - https://queue.taskcluster.net/v1/task/hA8dQlKTS3q2OXhD_wXxZg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 18:48:45 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/hA8dQlKTS3q2OXhD_wXxZg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 18:48:45 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/hA8dQlKTS3q2OXhD_wXxZg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 18:48:45 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/hA8dQlKTS3q2OXhD_wXxZg/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 18:48:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/hA8dQlKTS3q2OXhD_wXxZg/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 18:48:46 INFO - Downloaded 22523661 bytes. 18:48:46 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 18:48:46 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 18:48:46 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 18:48:48 INFO - Return code: 0 18:48:48 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 18:48:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:48:48 INFO - https://queue.taskcluster.net/v1/task/hA8dQlKTS3q2OXhD_wXxZg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 18:48:48 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/hA8dQlKTS3q2OXhD_wXxZg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 18:48:48 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/hA8dQlKTS3q2OXhD_wXxZg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 18:48:48 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/hA8dQlKTS3q2OXhD_wXxZg/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 18:48:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/hA8dQlKTS3q2OXhD_wXxZg/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 18:48:51 INFO - Downloaded 22523661 bytes. 18:48:51 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 18:48:51 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 18:48:51 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 18:48:53 INFO - Return code: 0 18:48:53 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')]} 18:48:53 INFO - https://queue.taskcluster.net/v1/task/hA8dQlKTS3q2OXhD_wXxZg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 18:48:53 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/hA8dQlKTS3q2OXhD_wXxZg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 18:48:53 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/hA8dQlKTS3q2OXhD_wXxZg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 18:48:53 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/hA8dQlKTS3q2OXhD_wXxZg/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 18:48:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/hA8dQlKTS3q2OXhD_wXxZg/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 18:48:53 INFO - Downloaded 11130997 bytes. 18:48:53 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 18:48:53 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 18:48:53 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 18:48:54 INFO - Return code: 0 18:48:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:48:54 INFO - https://queue.taskcluster.net/v1/task/hA8dQlKTS3q2OXhD_wXxZg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 18:48:54 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/hA8dQlKTS3q2OXhD_wXxZg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 18:48:54 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/hA8dQlKTS3q2OXhD_wXxZg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 18:48:54 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/hA8dQlKTS3q2OXhD_wXxZg/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 18:48:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/hA8dQlKTS3q2OXhD_wXxZg/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 18:48:56 INFO - Downloaded 57430356 bytes. 18:48:56 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/hA8dQlKTS3q2OXhD_wXxZg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 18:48:56 INFO - mkdir: /builds/slave/test-pgo/properties 18:48:56 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 18:48:56 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 18:48:56 INFO - Contents: 18:48:56 INFO - build_url:https://queue.taskcluster.net/v1/task/hA8dQlKTS3q2OXhD_wXxZg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 18:48:56 INFO - Running post-action listener: _resource_record_post_action 18:48:56 INFO - Running post-action listener: set_extra_try_arguments 18:48:56 INFO - ##### 18:48:56 INFO - ##### Running populate-webroot step. 18:48:56 INFO - ##### 18:48:56 INFO - Running pre-action listener: _resource_record_pre_action 18:48:56 INFO - Running main action method: populate_webroot 18:48:56 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 18:48:56 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 18:48:56 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 18:48:56 INFO - '../fennec_ids.txt'], 18:48:56 INFO - 'tests': ['tcheck2']}, 18:48:56 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 18:48:56 INFO - '--tppagecycles', 18:48:56 INFO - '7'], 18:48:56 INFO - 'tests': ['tsvgm']}}, 18:48:56 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 18:48:56 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 18:48:56 INFO - 'tests': ['tresize', 'tcanvasmark']}, 18:48:56 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 18:48:56 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 18:48:56 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 18:48:56 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:48:56 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:48:56 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:48:56 INFO - 'talos_options': ['--e10s'], 18:48:56 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:48:56 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:48:56 INFO - 'tests': ['damp', 'tps']}, 18:48:56 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:48:56 INFO - 'talos_options': ['--e10s'], 18:48:56 INFO - 'tests': ['damp', 'tps']}, 18:48:56 INFO - 'g3': {'tests': ['dromaeo_dom']}, 18:48:56 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 18:48:56 INFO - 'other': {'tests': ['a11yr', 18:48:56 INFO - 'ts_paint', 18:48:56 INFO - 'tpaint', 18:48:56 INFO - 'sessionrestore', 18:48:56 INFO - 'sessionrestore_no_auto_restore']}, 18:48:56 INFO - 'other-e10s': {'talos_options': ['--e10s'], 18:48:56 INFO - 'tests': ['a11yr', 18:48:56 INFO - 'ts_paint', 18:48:56 INFO - 'tpaint', 18:48:56 INFO - 'sessionrestore', 18:48:56 INFO - 'sessionrestore_no_auto_restore']}, 18:48:56 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 18:48:56 INFO - 'tests': ['a11yr', 18:48:56 INFO - 'ts_paint', 18:48:56 INFO - 'tpaint', 18:48:56 INFO - 'sessionrestore', 18:48:56 INFO - 'sessionrestore_no_auto_restore']}, 18:48:56 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 18:48:56 INFO - 'tests': ['a11yr', 18:48:56 INFO - 'ts_paint', 18:48:56 INFO - 'tpaint', 18:48:56 INFO - 'sessionrestore', 18:48:56 INFO - 'sessionrestore_no_auto_restore']}, 18:48:56 INFO - 'other_l64': {'tests': ['a11yr', 18:48:56 INFO - 'ts_paint', 18:48:56 INFO - 'tpaint', 18:48:56 INFO - 'sessionrestore', 18:48:56 INFO - 'sessionrestore_no_auto_restore']}, 18:48:56 INFO - 'other_nol64': {'tests': ['a11yr', 18:48:56 INFO - 'ts_paint', 18:48:56 INFO - 'tpaint', 18:48:56 INFO - 'sessionrestore', 18:48:56 INFO - 'sessionrestore_no_auto_restore']}, 18:48:56 INFO - 'svgr': {'tests': ['tsvgx', 18:48:56 INFO - 'tsvgr_opacity', 18:48:56 INFO - 'tart', 18:48:56 INFO - 'tscrollx', 18:48:56 INFO - 'cart']}, 18:48:56 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 18:48:56 INFO - 'tests': ['tsvgx', 18:48:56 INFO - 'tsvgr_opacity', 18:48:56 INFO - 'tart', 18:48:56 INFO - 'tscrollx', 18:48:56 INFO - 'cart']}, 18:48:56 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:48:56 INFO - 'tests': ['tp5o']}, 18:48:56 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:48:56 INFO - 'talos_options': ['--e10s'], 18:48:56 INFO - 'tests': ['tp5o']}, 18:48:56 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:48:56 INFO - 'talos_options': ['--xperf_path', 18:48:56 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:48:56 INFO - 'tests': ['tp5n']}, 18:48:56 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:48:56 INFO - 'talos_options': ['--e10s', 18:48:56 INFO - '--xperf_path', 18:48:56 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:48:56 INFO - 'tests': ['tp5n']}}, 18:48:56 INFO - 'talos.zip': {'path': '', 18:48:56 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 18:48:56 INFO - Running post-action listener: _resource_record_post_action 18:48:56 INFO - ##### 18:48:56 INFO - ##### Running create-virtualenv step. 18:48:56 INFO - ##### 18:48:56 INFO - Running pre-action listener: _resource_record_pre_action 18:48:56 INFO - Running main action method: create_virtualenv 18:48:56 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 18:48:56 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 18:48:56 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 18:48:56 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 18:48:56 INFO - Using real prefix '/usr' 18:48:56 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 18:48:56 INFO - Installing distribute.............................................................................................................................................................................................done. 18:48:58 INFO - Installing pip.................done. 18:48:58 INFO - Return code: 0 18:48:58 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 18:48:58 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')]} 18:48:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:48:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:48:58 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')]} 18:48:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:48:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:48:58 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 0x7fad38189c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x120a6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12bc7c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1300d70>, '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 0x1301b20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1301fb0>, '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': 'b4e1481c633df10bed3f4cc0000001c7-1448074121.649156-979618878', '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 18:48:58 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 18:48:58 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 18:48:58 INFO - Using env: {'DISPLAY': ':0', 18:48:58 INFO - 'HOME': '/home/cltbld', 18:48:58 INFO - 'LANG': 'en_US.UTF-8', 18:48:58 INFO - 'LANGUAGE': 'en_US:en', 18:48:58 INFO - 'LOGNAME': 'cltbld', 18:48:58 INFO - 'MAIL': '/var/mail/cltbld', 18:48:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:48:58 INFO - 'MOZ_NO_REMOTE': '1', 18:48:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:48:58 INFO - 'NO_EM_RESTART': '1', 18:48:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:48:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 18:48:58 INFO - 'PWD': '/builds/slave/test-pgo', 18:48:58 INFO - 'SHELL': '/bin/bash', 18:48:58 INFO - 'SHLVL': '1', 18:48:58 INFO - 'TERM': 'linux', 18:48:58 INFO - 'TMOUT': '86400', 18:48:58 INFO - 'USER': 'cltbld', 18:48:58 INFO - 'XDG_SESSION_COOKIE': 'b4e1481c633df10bed3f4cc0000001c7-1448074121.649156-979618878', 18:48:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:48:58 INFO - '_': '/tools/buildbot/bin/python'} 18:48:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:48:58 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 18:48:58 INFO - Cleaning up... 18:48:58 INFO - Return code: 0 18:48:58 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 18:48:58 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')]} 18:48:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:48:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:48:58 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')]} 18:48:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:48:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:48:58 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 0x7fad38189c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x120a6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12bc7c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1300d70>, '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 0x1301b20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1301fb0>, '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': 'b4e1481c633df10bed3f4cc0000001c7-1448074121.649156-979618878', '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 18:48:58 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 18:48:58 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 18:48:58 INFO - Using env: {'DISPLAY': ':0', 18:48:58 INFO - 'HOME': '/home/cltbld', 18:48:58 INFO - 'LANG': 'en_US.UTF-8', 18:48:58 INFO - 'LANGUAGE': 'en_US:en', 18:48:58 INFO - 'LOGNAME': 'cltbld', 18:48:58 INFO - 'MAIL': '/var/mail/cltbld', 18:48:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:48:58 INFO - 'MOZ_NO_REMOTE': '1', 18:48:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:48:58 INFO - 'NO_EM_RESTART': '1', 18:48:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:48:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 18:48:58 INFO - 'PWD': '/builds/slave/test-pgo', 18:48:58 INFO - 'SHELL': '/bin/bash', 18:48:58 INFO - 'SHLVL': '1', 18:48:58 INFO - 'TERM': 'linux', 18:48:58 INFO - 'TMOUT': '86400', 18:48:58 INFO - 'USER': 'cltbld', 18:48:58 INFO - 'XDG_SESSION_COOKIE': 'b4e1481c633df10bed3f4cc0000001c7-1448074121.649156-979618878', 18:48:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:48:58 INFO - '_': '/tools/buildbot/bin/python'} 18:48:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:48:59 INFO - Downloading/unpacking psutil>=0.7.1 18:48: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 18:48: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 18:48: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 18:48: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 18:48: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 18:48: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 18:49:00 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 18:49:00 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 18:49:00 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 18:49:00 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:49:00 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:49:00 INFO - Installing collected packages: psutil 18:49:00 INFO - Running setup.py install for psutil 18:49:00 INFO - building 'psutil._psutil_linux' extension 18:49:00 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 18:49:01 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 18:49:01 INFO - building 'psutil._psutil_posix' extension 18:49:01 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 18:49:01 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 18:49:01 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:49:01 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:49:01 INFO - Successfully installed psutil 18:49:01 INFO - Cleaning up... 18:49:01 INFO - Return code: 0 18:49:01 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 18:49: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')]} 18:49:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:49:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:49: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')]} 18:49:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:49:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:49: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', '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 0x7fad38189c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x120a6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12bc7c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1300d70>, '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 0x1301b20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1301fb0>, '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': 'b4e1481c633df10bed3f4cc0000001c7-1448074121.649156-979618878', '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 18:49: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', 'mozsystemmonitor==0.0.0'] in /builds/slave/test-pgo/build 18:49: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 mozsystemmonitor==0.0.0 18:49:01 INFO - Using env: {'DISPLAY': ':0', 18:49:01 INFO - 'HOME': '/home/cltbld', 18:49:01 INFO - 'LANG': 'en_US.UTF-8', 18:49:01 INFO - 'LANGUAGE': 'en_US:en', 18:49:01 INFO - 'LOGNAME': 'cltbld', 18:49:01 INFO - 'MAIL': '/var/mail/cltbld', 18:49:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:49:01 INFO - 'MOZ_NO_REMOTE': '1', 18:49:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:49:01 INFO - 'NO_EM_RESTART': '1', 18:49:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:49:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 18:49:01 INFO - 'PWD': '/builds/slave/test-pgo', 18:49:01 INFO - 'SHELL': '/bin/bash', 18:49:01 INFO - 'SHLVL': '1', 18:49:01 INFO - 'TERM': 'linux', 18:49:01 INFO - 'TMOUT': '86400', 18:49:01 INFO - 'USER': 'cltbld', 18:49:01 INFO - 'XDG_SESSION_COOKIE': 'b4e1481c633df10bed3f4cc0000001c7-1448074121.649156-979618878', 18:49:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:49:01 INFO - '_': '/tools/buildbot/bin/python'} 18:49:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:49:01 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 18:49: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 18:49: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 18:49: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 18:49: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 18:49: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 18:49: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 18:49:03 INFO - Downloading mozsystemmonitor-0.0.tar.gz 18:49:03 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 18:49:03 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 18:49:03 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 18:49:03 INFO - Installing collected packages: mozsystemmonitor 18:49:03 INFO - Running setup.py install for mozsystemmonitor 18:49:03 INFO - Successfully installed mozsystemmonitor 18:49:03 INFO - Cleaning up... 18:49:03 INFO - Return code: 0 18:49:03 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 18:49:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:49:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:49:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:49:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:49:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:49:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:49:03 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--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 0x7fad38189c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x120a6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12bc7c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1300d70>, '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 0x1301b20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1301fb0>, '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': 'b4e1481c633df10bed3f4cc0000001c7-1448074121.649156-979618878', '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 18:49:03 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 18:49:03 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 18:49:03 INFO - Using env: {'DISPLAY': ':0', 18:49:03 INFO - 'HOME': '/home/cltbld', 18:49:03 INFO - 'LANG': 'en_US.UTF-8', 18:49:03 INFO - 'LANGUAGE': 'en_US:en', 18:49:03 INFO - 'LOGNAME': 'cltbld', 18:49:03 INFO - 'MAIL': '/var/mail/cltbld', 18:49:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:49:03 INFO - 'MOZ_NO_REMOTE': '1', 18:49:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:49:03 INFO - 'NO_EM_RESTART': '1', 18:49:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:49:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 18:49:03 INFO - 'PWD': '/builds/slave/test-pgo', 18:49:03 INFO - 'SHELL': '/bin/bash', 18:49:03 INFO - 'SHLVL': '1', 18:49:03 INFO - 'TERM': 'linux', 18:49:03 INFO - 'TMOUT': '86400', 18:49:03 INFO - 'USER': 'cltbld', 18:49:03 INFO - 'XDG_SESSION_COOKIE': 'b4e1481c633df10bed3f4cc0000001c7-1448074121.649156-979618878', 18:49:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:49:03 INFO - '_': '/tools/buildbot/bin/python'} 18:49:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:49:03 INFO - Downloading/unpacking blobuploader==1.2.4 18:49: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 18:49: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 18:49: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 18:49: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 18:49: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 18:49: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 18:49:05 INFO - Downloading blobuploader-1.2.4.tar.gz 18:49:05 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 18:49:05 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 18:49:05 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 18:49:05 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 18:49:05 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 18:49:05 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 18:49:05 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 18:49:05 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 18:49:05 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 18:49:05 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 18:49:05 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 18:49:05 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 18:49:05 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 18:49:05 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 18:49:05 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 18:49:05 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 18:49:05 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 18:49:05 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 18:49:05 INFO - Downloading docopt-0.6.1.tar.gz 18:49:05 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 18:49:05 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 18:49:06 INFO - Installing collected packages: blobuploader, requests, docopt 18:49:06 INFO - Running setup.py install for blobuploader 18:49:06 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 18:49:06 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 18:49:06 INFO - Running setup.py install for requests 18:49:06 INFO - Running setup.py install for docopt 18:49:06 INFO - Successfully installed blobuploader requests docopt 18:49:06 INFO - Cleaning up... 18:49:06 INFO - Return code: 0 18:49:06 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 18:49:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:49:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:49:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:49:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:49:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:49:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:49:06 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 0x7fad38189c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x120a6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12bc7c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1300d70>, '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 0x1301b20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1301fb0>, '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': 'b4e1481c633df10bed3f4cc0000001c7-1448074121.649156-979618878', '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 18:49:06 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 18:49:06 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 18:49:06 INFO - Using env: {'DISPLAY': ':0', 18:49:06 INFO - 'HOME': '/home/cltbld', 18:49:06 INFO - 'LANG': 'en_US.UTF-8', 18:49:06 INFO - 'LANGUAGE': 'en_US:en', 18:49:06 INFO - 'LOGNAME': 'cltbld', 18:49:06 INFO - 'MAIL': '/var/mail/cltbld', 18:49:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:49:06 INFO - 'MOZ_NO_REMOTE': '1', 18:49:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:49:06 INFO - 'NO_EM_RESTART': '1', 18:49:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:49:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 18:49:06 INFO - 'PWD': '/builds/slave/test-pgo', 18:49:06 INFO - 'SHELL': '/bin/bash', 18:49:06 INFO - 'SHLVL': '1', 18:49:06 INFO - 'TERM': 'linux', 18:49:06 INFO - 'TMOUT': '86400', 18:49:06 INFO - 'USER': 'cltbld', 18:49:06 INFO - 'XDG_SESSION_COOKIE': 'b4e1481c633df10bed3f4cc0000001c7-1448074121.649156-979618878', 18:49:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:49:06 INFO - '_': '/tools/buildbot/bin/python'} 18:49:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:49:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 18:49:06 INFO - Running setup.py (path:/tmp/pip-Iidx5G-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 18:49:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 18:49:06 INFO - Running setup.py (path:/tmp/pip-d2SpSS-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 18:49:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 18:49:07 INFO - Running setup.py (path:/tmp/pip-fRl3u2-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 18:49:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 18:49:07 INFO - Running setup.py (path:/tmp/pip-qhRfQT-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 18:49:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 18:49:07 INFO - Running setup.py (path:/tmp/pip-mpAFnk-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 18:49:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 18:49:07 INFO - Running setup.py (path:/tmp/pip-DBr6Pc-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 18:49:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 18:49:07 INFO - Running setup.py (path:/tmp/pip-uZ218T-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 18:49:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 18:49:07 INFO - Running setup.py (path:/tmp/pip-1N2J8r-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 18:49:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 18:49:07 INFO - Running setup.py (path:/tmp/pip-tt3yMZ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 18:49:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 18:49:07 INFO - Running setup.py (path:/tmp/pip-n4q75D-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 18:49:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 18:49:07 INFO - Running setup.py (path:/tmp/pip-j6QHFI-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 18:49:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 18:49:07 INFO - Running setup.py (path:/tmp/pip-wdeBbV-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 18:49:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 18:49:07 INFO - Running setup.py (path:/tmp/pip-W2PleY-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 18:49:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 18:49:07 INFO - Running setup.py (path:/tmp/pip-bE5dtP-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 18:49:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 18:49:07 INFO - Running setup.py (path:/tmp/pip-DEpuYh-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 18:49:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 18:49:07 INFO - Running setup.py (path:/tmp/pip-XmjSqi-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 18:49:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 18:49:08 INFO - Running setup.py (path:/tmp/pip-Ump2PF-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 18:49:08 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 18:49:08 INFO - Running setup.py install for manifestparser 18:49:08 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 18:49:08 INFO - Running setup.py install for mozcrash 18:49:08 INFO - Running setup.py install for mozdebug 18:49:08 INFO - Running setup.py install for mozdevice 18:49:08 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 18:49:08 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 18:49:08 INFO - Running setup.py install for mozfile 18:49:08 INFO - Running setup.py install for mozhttpd 18:49:08 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 18:49:08 INFO - Running setup.py install for mozinfo 18:49:08 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 18:49:08 INFO - Running setup.py install for mozInstall 18:49:08 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 18:49:08 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 18:49:08 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 18:49:08 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 18:49:08 INFO - Running setup.py install for mozleak 18:49:08 INFO - Running setup.py install for mozlog 18:49:09 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 18:49:09 INFO - Running setup.py install for moznetwork 18:49:09 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 18:49:09 INFO - Running setup.py install for mozprocess 18:49:09 INFO - Running setup.py install for mozprofile 18:49:09 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 18:49:09 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 18:49:09 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 18:49:09 INFO - Running setup.py install for mozrunner 18:49:09 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 18:49:09 INFO - Running setup.py install for mozscreenshot 18:49:09 INFO - Running setup.py install for moztest 18:49:09 INFO - Running setup.py install for mozversion 18:49:09 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 18:49:09 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 18:49:09 INFO - Cleaning up... 18:49:09 INFO - Return code: 0 18:49:09 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 18:49:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:49:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:49:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:49:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:49:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:49:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:49:09 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/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 0x7fad38189c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x120a6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12bc7c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1300d70>, '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 0x1301b20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1301fb0>, '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': 'b4e1481c633df10bed3f4cc0000001c7-1448074121.649156-979618878', '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 18:49:09 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/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 18:49:09 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 -r /builds/slave/test-pgo/build/tests/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 18:49:09 INFO - Using env: {'DISPLAY': ':0', 18:49:09 INFO - 'HOME': '/home/cltbld', 18:49:09 INFO - 'LANG': 'en_US.UTF-8', 18:49:09 INFO - 'LANGUAGE': 'en_US:en', 18:49:09 INFO - 'LOGNAME': 'cltbld', 18:49:09 INFO - 'MAIL': '/var/mail/cltbld', 18:49:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:49:09 INFO - 'MOZ_NO_REMOTE': '1', 18:49:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:49:09 INFO - 'NO_EM_RESTART': '1', 18:49:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:49:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 18:49:09 INFO - 'PWD': '/builds/slave/test-pgo', 18:49:09 INFO - 'SHELL': '/bin/bash', 18:49:09 INFO - 'SHLVL': '1', 18:49:09 INFO - 'TERM': 'linux', 18:49:09 INFO - 'TMOUT': '86400', 18:49:09 INFO - 'USER': 'cltbld', 18:49:09 INFO - 'XDG_SESSION_COOKIE': 'b4e1481c633df10bed3f4cc0000001c7-1448074121.649156-979618878', 18:49:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:49:09 INFO - '_': '/tools/buildbot/bin/python'} 18:49:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:49:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 18:49:10 INFO - Running setup.py (path:/tmp/pip-6fDlww-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 18:49:10 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)) 18:49:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 18:49:10 INFO - Running setup.py (path:/tmp/pip-PaNgXe-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 18:49:10 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)) 18:49:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 18:49:10 INFO - Running setup.py (path:/tmp/pip-kpH_0k-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 18:49:10 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)) 18:49:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 18:49:10 INFO - Running setup.py (path:/tmp/pip-6jbJOL-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 18:49:10 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)) 18:49:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 18:49:10 INFO - Running setup.py (path:/tmp/pip-b06eB9-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 18:49:10 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)) 18:49:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 18:49:10 INFO - Running setup.py (path:/tmp/pip-C_Q0_E-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 18:49:10 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)) 18:49:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 18:49:10 INFO - Running setup.py (path:/tmp/pip-F2ia1f-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 18:49:10 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)) 18:49:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 18:49:10 INFO - Running setup.py (path:/tmp/pip-OfGH18-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 18:49:10 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)) 18:49:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 18:49:10 INFO - Running setup.py (path:/tmp/pip-pRk76m-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 18:49:10 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)) 18:49:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 18:49:10 INFO - Running setup.py (path:/tmp/pip-5UivYz-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 18:49:10 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)) 18:49:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 18:49:10 INFO - Running setup.py (path:/tmp/pip-Idbo_L-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 18:49:10 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)) 18:49:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 18:49:10 INFO - Running setup.py (path:/tmp/pip-rJHOU6-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 18:49:10 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)) 18:49:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 18:49:10 INFO - Running setup.py (path:/tmp/pip-aoIJJ9-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 18:49:11 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)) 18:49:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 18:49:11 INFO - Running setup.py (path:/tmp/pip-0PVIp9-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 18:49:11 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)) 18:49:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 18:49:11 INFO - Running setup.py (path:/tmp/pip-4Jhreb-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 18:49:11 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)) 18:49:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 18:49:11 INFO - Running setup.py (path:/tmp/pip-Kj2toL-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 18:49:11 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)) 18:49:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 18:49:11 INFO - Running setup.py (path:/tmp/pip-rMZIVz-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 18:49:11 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)) 18:49:11 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)) 18:49: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.16->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 18:49:11 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)) 18:49: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 mozdevice==0.47->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 18:49:11 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)) 18:49:11 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.0->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 18:49:11 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 18:49:11 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 18:49:11 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 18:49:11 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 18:49:11 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 18:49:11 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 18:49:12 INFO - Downloading blessings-1.5.1.tar.gz 18:49:12 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 18:49:12 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 18:49:13 INFO - Installing collected packages: blessings 18:49:13 INFO - Running setup.py install for blessings 18:49:13 INFO - Successfully installed blessings 18:49:13 INFO - Cleaning up... 18:49:13 INFO - Return code: 0 18:49:13 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 18:49:13 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 18:49:13 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 18:49:13 INFO - Reading from file tmpfile_stdout 18:49:13 INFO - Current package versions: 18:49:13 INFO - argparse == 1.2.1 18:49:13 INFO - blessings == 1.5.1 18:49:13 INFO - blobuploader == 1.2.4 18:49:13 INFO - docopt == 0.6.1 18:49:13 INFO - manifestparser == 1.1 18:49:13 INFO - mozInstall == 1.12 18:49:13 INFO - mozcrash == 0.16 18:49:13 INFO - mozdebug == 0.1 18:49:13 INFO - mozdevice == 0.47 18:49:13 INFO - mozfile == 1.2 18:49:13 INFO - mozhttpd == 0.7 18:49:13 INFO - mozinfo == 0.9 18:49:13 INFO - mozleak == 0.1 18:49:13 INFO - mozlog == 3.0 18:49:13 INFO - moznetwork == 0.27 18:49:13 INFO - mozprocess == 0.22 18:49:13 INFO - mozprofile == 0.27 18:49:13 INFO - mozrunner == 6.11 18:49:13 INFO - mozscreenshot == 0.1 18:49:13 INFO - mozsystemmonitor == 0.0 18:49:13 INFO - moztest == 0.7 18:49:13 INFO - mozversion == 1.4 18:49:13 INFO - psutil == 3.1.1 18:49:13 INFO - requests == 1.2.3 18:49:13 INFO - wsgiref == 0.1.2 18:49:13 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 18:49:13 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')]} 18:49:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:49:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:49:13 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')]} 18:49:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:49:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:49:13 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 0x7fad38189c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x120a6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12bc7c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1300d70>, '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 0x1301b20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1301fb0>, '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': 'b4e1481c633df10bed3f4cc0000001c7-1448074121.649156-979618878', '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 18:49:13 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 18:49:13 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 18:49:13 INFO - Using env: {'DISPLAY': ':0', 18:49:13 INFO - 'HOME': '/home/cltbld', 18:49:13 INFO - 'LANG': 'en_US.UTF-8', 18:49:13 INFO - 'LANGUAGE': 'en_US:en', 18:49:13 INFO - 'LOGNAME': 'cltbld', 18:49:13 INFO - 'MAIL': '/var/mail/cltbld', 18:49:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:49:13 INFO - 'MOZ_NO_REMOTE': '1', 18:49:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:49:13 INFO - 'NO_EM_RESTART': '1', 18:49:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:49:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 18:49:13 INFO - 'PWD': '/builds/slave/test-pgo', 18:49:13 INFO - 'SHELL': '/bin/bash', 18:49:13 INFO - 'SHLVL': '1', 18:49:13 INFO - 'TERM': 'linux', 18:49:13 INFO - 'TMOUT': '86400', 18:49:13 INFO - 'USER': 'cltbld', 18:49:13 INFO - 'XDG_SESSION_COOKIE': 'b4e1481c633df10bed3f4cc0000001c7-1448074121.649156-979618878', 18:49:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:49:13 INFO - '_': '/tools/buildbot/bin/python'} 18:49:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:49:13 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)) 18:49:13 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)) 18:49:13 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)) 18:49:13 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)) 18:49:13 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)) 18:49:13 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)) 18:49:13 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)) 18:49:13 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)) 18:49:13 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)) 18:49:13 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)) 18:49:13 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)) 18:49:13 INFO - Cleaning up... 18:49:13 INFO - Return code: 0 18:49:13 INFO - Running post-action listener: _resource_record_post_action 18:49:13 INFO - Running post-action listener: _start_resource_monitoring 18:49:13 INFO - Starting resource monitoring. 18:49:13 INFO - ##### 18:49:13 INFO - ##### Running install step. 18:49:13 INFO - ##### 18:49:13 INFO - Running pre-action listener: _resource_record_pre_action 18:49:13 INFO - Running main action method: install 18:49:13 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 18:49:13 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 18:49:13 INFO - Reading from file tmpfile_stdout 18:49:13 INFO - Detecting whether we're running mozinstall >=1.0... 18:49:13 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 18:49:13 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 18:49:13 INFO - Reading from file tmpfile_stdout 18:49:13 INFO - Output received: 18:49:13 INFO - Usage: mozinstall [options] installer 18:49:13 INFO - Options: 18:49:13 INFO - -h, --help show this help message and exit 18:49:13 INFO - -d DEST, --destination=DEST 18:49:13 INFO - Directory to install application into. [default: 18:49:13 INFO - "/builds/slave/test-pgo"] 18:49:13 INFO - --app=APP Application being installed. [default: firefox] 18:49:13 INFO - mkdir: /builds/slave/test-pgo/build/application 18:49:13 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'] 18:49:13 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 18:49:28 INFO - Reading from file tmpfile_stdout 18:49:28 INFO - Output received: 18:49:28 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 18:49:28 INFO - Running post-action listener: _resource_record_post_action 18:49:28 INFO - ##### 18:49:28 INFO - ##### Running run-tests step. 18:49:28 INFO - ##### 18:49:28 INFO - Running pre-action listener: _resource_record_pre_action 18:49:28 INFO - Running main action method: run_tests 18:49:28 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 18:49:28 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 18:49:28 INFO - Python 2.7.3 18:49:28 INFO - Return code: 0 18:49:28 INFO - grabbing minidump binary from tooltool 18:49:28 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')]} 18:49:28 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 0x1300d70>, '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 0x1301b20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1301fb0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 18:49:28 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 18:49:28 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 18:49:28 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 18:49:28 INFO - Return code: 0 18:49:28 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 18:49:28 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 18:49:28 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 18:49:28 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 18:49:28 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 18:49:28 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/hA8dQlKTS3q2OXhD_wXxZg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-001', '--webServer', 'localhost'] in /builds/slave/test-pgo/build 18:49:28 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --debug --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/hA8dQlKTS3q2OXhD_wXxZg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-001 --webServer localhost 18:49:28 INFO - Using env: {'DISPLAY': ':0', 18:49:28 INFO - 'HOME': '/home/cltbld', 18:49:28 INFO - 'LANG': 'en_US.UTF-8', 18:49:28 INFO - 'LANGUAGE': 'en_US:en', 18:49:28 INFO - 'LOGNAME': 'cltbld', 18:49:28 INFO - 'MAIL': '/var/mail/cltbld', 18:49:28 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 18:49:28 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 18:49:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:49:28 INFO - 'MOZ_NO_REMOTE': '1', 18:49:28 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 18:49:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:49:28 INFO - 'NO_EM_RESTART': '1', 18:49:28 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:49:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 18:49:28 INFO - 'PWD': '/builds/slave/test-pgo', 18:49:28 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 18:49:28 INFO - 'SHELL': '/bin/bash', 18:49:28 INFO - 'SHLVL': '1', 18:49:28 INFO - 'TERM': 'linux', 18:49:28 INFO - 'TMOUT': '86400', 18:49:28 INFO - 'USER': 'cltbld', 18:49:28 INFO - 'XDG_SESSION_COOKIE': 'b4e1481c633df10bed3f4cc0000001c7-1448074121.649156-979618878', 18:49:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:49:28 INFO - '_': '/tools/buildbot/bin/python'} 18:49:28 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/hA8dQlKTS3q2OXhD_wXxZg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-001', '--webServer', 'localhost'] with output_timeout 3600 18:49:28 INFO - mozversion INFO | application_buildid: 20151120163003 18:49:28 INFO - mozversion INFO | application_changeset: 3f5afaf4e6b72c4b1a20749b4ce7d945add5299f 18:49:28 INFO - mozversion INFO | application_display_name: Nightly 18:49:28 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 18:49:28 INFO - mozversion INFO | application_name: Firefox 18:49:28 INFO - mozversion INFO | application_remotingname: firefox 18:49:28 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/mozilla-central 18:49:28 INFO - mozversion INFO | application_vendor: Mozilla 18:49:28 INFO - mozversion INFO | application_version: 45.0a1 18:49:28 INFO - mozversion INFO | platform_buildid: 20151120163003 18:49:28 INFO - mozversion INFO | platform_changeset: 3f5afaf4e6b72c4b1a20749b4ce7d945add5299f 18:49:28 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/mozilla-central 18:49:28 INFO - mozversion INFO | platform_version: 45.0a1 18:49:28 INFO - 2015-11-20 18:49:28,678 DEBUG : using testdate: 1448074168 18:49:28 INFO - 2015-11-20 18:49:28,678 DEBUG : actual date: 1448074168 18:49:28 INFO - 2015-11-20 18:49:28,687 INFO : starting webserver on 'localhost:53774' 18:49:28 INFO - 2015-11-20 18:49:28,687 INFO : Starting test suite talos-linux64-ix-001 18:49:28 INFO - 2015-11-20 18:49:28,688 INFO : Starting test dromaeo_css 18:49:28 INFO - 2015-11-20 18:49:28,688 DEBUG : operating with platform_type : linux_ 18:49:28 INFO - 2015-11-20 18:49:28,688 INFO : Initialising browser for dromaeo_css test... 18:49:28 INFO - 2015-11-20 18:49:28,705 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp1M9HYK/profile http://localhost:53774/getInfo.html 18:49:32 INFO - 2015-11-20 18:49:32,862 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 18:49:32 INFO - 2015-11-20 18:49:32,863 DEBUG : BROWSER_OUTPUT: colorDepth:24 18:49:32 INFO - 2015-11-20 18:49:32,863 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 18:49:32 INFO - 2015-11-20 18:49:32,863 DEBUG : BROWSER_OUTPUT: __metrics 18:49:33 INFO - 2015-11-20 18:49:33,004 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 18:49:34 INFO - 2015-11-20 18:49:34,275 INFO : Browser initialized. 18:49:34 INFO - 2015-11-20 18:49:34,275 INFO : Running cycle 1/1 for dromaeo_css test... 18:49:34 INFO - 2015-11-20 18:49:34,276 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp1M9HYK/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 18:49:46 INFO - 2015-11-20 18:49:46,015 DEBUG : BROWSER_OUTPUT: RSS: Main: 141783040 18:49:46 INFO - 2015-11-20 18:49:46,015 DEBUG : BROWSER_OUTPUT: 18:50:37 INFO - 2015-11-20 18:50:37,581 DEBUG : BROWSER_OUTPUT: 1448074237575 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] 18:52:46 INFO - 2015-11-20 18:52:46,730 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53774/tests/dromaeo/cssquery-dojo.html (next: http://localhost:53774/tests/dromaeo/cssquery-ext.html) 18:52:47 INFO - 2015-11-20 18:52:47,915 DEBUG : BROWSER_OUTPUT: RSS: Main: 266432512 18:52:47 INFO - 2015-11-20 18:52:47,915 DEBUG : BROWSER_OUTPUT: 18:55:50 INFO - 2015-11-20 18:55:50,280 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53774/tests/dromaeo/cssquery-ext.html (next: http://localhost:53774/tests/dromaeo/cssquery-jquery.html) 18:55:50 INFO - 2015-11-20 18:55:50,854 DEBUG : BROWSER_OUTPUT: RSS: Main: 224382976 18:55:50 INFO - 2015-11-20 18:55:50,855 DEBUG : BROWSER_OUTPUT: 18:58:52 INFO - 2015-11-20 18:58:52,877 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53774/tests/dromaeo/cssquery-jquery.html (next: http://localhost:53774/tests/dromaeo/cssquery-mootools.html) 18:58:53 INFO - 2015-11-20 18:58:53,450 DEBUG : BROWSER_OUTPUT: RSS: Main: 218615808 18:58:53 INFO - 2015-11-20 18:58:53,450 DEBUG : BROWSER_OUTPUT: 19:01:55 INFO - 2015-11-20 19:01:55,292 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53774/tests/dromaeo/cssquery-mootools.html (next: http://localhost:53774/tests/dromaeo/cssquery-prototype.html) 19:01:55 INFO - 2015-11-20 19:01:55,873 DEBUG : BROWSER_OUTPUT: RSS: Main: 206598144 19:01:55 INFO - 2015-11-20 19:01:55,873 DEBUG : BROWSER_OUTPUT: 19:04:58 INFO - 2015-11-20 19:04:58,394 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53774/tests/dromaeo/cssquery-prototype.html (next: http://localhost:53774/tests/dromaeo/cssquery-yui.html) 19:04:58 INFO - 2015-11-20 19:04:58,967 DEBUG : BROWSER_OUTPUT: RSS: Main: 203571200 19:04:58 INFO - 2015-11-20 19:04:58,967 DEBUG : BROWSER_OUTPUT: 19:08:01 INFO - 2015-11-20 19:08:01,532 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53774/tests/dromaeo/cssquery-yui.html (next: http://localhost:53774/tests/dromaeo/cssquery-dojo.html) 19:08:01 INFO - 2015-11-20 19:08:01,790 DEBUG : BROWSER_OUTPUT: RSS: Main: 249180160 19:08:01 INFO - 2015-11-20 19:08:01,790 DEBUG : BROWSER_OUTPUT: 19:08:01 INFO - 2015-11-20 19:08:01,790 DEBUG : BROWSER_OUTPUT: __start_tp_report 19:08:01 INFO - 2015-11-20 19:08:01,790 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 19:08:01 INFO - 2015-11-20 19:08:01,790 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 19:08:01 INFO - 2015-11-20 19:08:01,790 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 19:08:01 INFO - 2015-11-20 19:08:01,790 DEBUG : BROWSER_OUTPUT: |0;dojo.html;3113.828739419332;3225.806451612902;3268.1339445047065;3277.098797830598;3299.208190034391;5242.135047717122;5332.440093790155;5371.301730774999;5419;5513.062779327519;5323.866903327419;5341.1187154119625;5351.25082488451;5357.08929481988;5416.91874621881;4896.87757806055;4974.278729584208;5002.574781143607;5022.522860328263;5066.1640829263315;4733.8343157989475;4973.204287314031;4983.377077865267;5024.572911302544;5059.241113832936;4848.587870031034;4874.3419638348905;4918.508149185089;4947.727874966876;4955.182394904837;4929.65492415531;4931.26031095335;4940.456549779521;4948.233023881268;4977.42759582649;4818.325434439182;4920.926186107211;4938.209886418156;4944.554990050912;4966.5778408835295;5175.456577059392;5245.527902488756;5341.278927344798;5353.759080841332;5368;5902.8819423611285;5909.970450147722;5914;5919.792807251725;5920.230370051909;5741.138829175616;5844.152597873284;5944.256967879015;5949.494292985101;5951.761929522814;5452.945470545284;5528.75120619565;5573.526250268773;5591.4688104629995;5593.077142271521;5898.557608179403;5912.17229587858;5922.555808314393;5935.465808077293;5962.552808539377;5624.0439125348785;5795.33353664334;5809.477147056785;5845.883082338414;5852.268466441695;5653.830385088454;5710.600257981984;5720.599558030981;5795.681237531892;5868.295804503487;5782;5833.67914764692;5837.416258374129;5842.152887831241;5844.970775146097;5584.832455026356;5811.476967072899;5822.155787410802;5826.70866456684;5834.620749651259;4456.9331460028125;4458.464984201852;4471.709338892962;4530.252508336088;4556.589906908328;3993.960060399359;4006.318925782624;4024.396340548941;4027.073773032219;4066.4103704962613;5590.496855283044;5591.552675785927;5600.551955843523;5601.131824567198;5626.634268772598;5547.278853749068;5690.317161940511;5723.77104915807;5878.470937615635;5894.145348924382;5587.860303492445;5598.720063996784;5601.551875849922;5602;5620.044592419216;4955.851324460272;4956.033573453215;4964.081644895706;4967.155583550805;5013.974930125326;5794.130880367894;5801.593888427769;5810.1865738796605;5993.910091348721;6099.908501372394;5815.563832712648;5845.590808643354;5888.94111058901;5891.882162356815;5895.852603684771;6010.789622363196;6017.3681763414215;6025.578209525466;6036.336003039574;6038.69806509664;5641.464060914206;5646.2942132233475;5700.458456446631;5732.34078081026;5836.066229403275;5823.505002074871;5836.766529338779;5838.299404071538;5840.123981402823;5856.472917437451;5773;5783.045797443375;5784.363719990713;5800.1299805029585;5806.622569532967;5531.8893622128135;5598.664080155204;5650.519705825051;5663.490285874291;5721.914171287351;5563.471470210324;5569.443055694398;5575.4424557543925;5577.553795696415;5578.163275508544;5690.37405885344;5712.228849105484;5737.168110624019;5746.569007324384;5758.193852860519;5417.349918009864;5506;5517.613767036269;5539.58453116026;5676.375598684224 19:08:01 INFO - 2015-11-20 19:08:01,790 DEBUG : BROWSER_OUTPUT: |1;ext.html;563.1412096552757;613.938606139386;616.7656290609568;618.3723520626568;619.8729260501597;32095.839520802394;39822;40218.59781402185;40224.19551608966;40243.59756402442;42219.577804221946;42614.786926065324;42650.786746066304;42768.57231427685;42798;7679.6160191990175;7810;8700.65197392105;8858.645654173826;8921.598528066253;7635.580043097628;7714.074311082678;10507.21195910306;10734.463276836126;10738.677839664822;10433.582656693723;10555.155587552978;10560.207984401162;10563.41901195434;10563.683089507327;7808;10367.688969330895;10449.47752612374;10459.215558833042;10466.738331541696;7656;10079.496025198783;10357.171426285879;10364.79270414595;10378.11785998191;36162.276754464765;36573;36624.26751464956;36645.450318245246;36705.08237294089;3280.5899262592175;3319.3029463812627;3327.1349449143395;3420.3330350581646;3436.742244331685;29725.55411668827;30352;30476.514057589346;30906.53640195399;31748.20629484258;3252.8339083292394;3271.574695289621;3289.0954987378423;3411.385950528904;3414.8634054637787;276944;277477;277671;278224;278641;54280;55166.72416637971;55491.44508554863;55721.442785572435;56270.1864906753;53627;54206.45793542093;54370.45629543654;54607;54683.453165467836;14812.111273323635;14998.925005374904;15011.624709382353;15028.474003409829;15033.323500442506;11458;11473.885261147281;11519.366434846164;11535.36555489456;11543.36511491876;18048.639027219644;18621;18804.90597547031;18882.81117188838;18937;7647.19399734237;7739.651715672809;7931.325837303893;7981.48120372174;8015.83968320642;935.5322338830584;978.7602037500716;984.4683870709737;1002.2683441088046;1088.689723428819;24997.250082497554;25022.37444063913;26916.327091822863;27276.31809204786;27451;1028.4497793680346;1065.8774240962234;1066.4987455895716;1074.9516271767789;1159.2349049627373;14302.712755852022;14349.282535873164;14355.56933292003;14484.203368814817;14520.782188267185;302189;306530;307070;307343;307474;53244.46755532473;53477.1978420324;53568;53598.46401535935;53610.73194634002;1323.993380033113;1326.7943468762357;1342.6911810283493;1343.8588948160498;1345.0987838148465;27046.72953270442;27513.44973100567;27791.44417111606;27951;28084;42492.57507424886;45374.54625453703;45701.54298456973;45773.54226457693;45807;215956;217040;297838;308035;308058;29392.412151756416;29554;29639;29716;29730.405391892473;40581.39127913143;42848.35727464028;43311;43897.34153987757;44033.11933761243;37297;37377.81311093427;37509.4373584391;38645.61354386533;38705.806470967465;35547.11132221715;35609.28781424409;36466.27067458689;36659;36843.07892302714;33617.495737564444;33639.83180084182;33646.15884602807;35755.46366804448;36090.63909360873;29204.561931570617;30286.54570181493;30545;30593;30594.694053059186;24824.533796913824;25013.374665633506;25114.121005765443;25309.367265818502;25501 19:08:01 INFO - 2015-11-20 19:08:01,790 DEBUG : BROWSER_OUTPUT: |2;jquery.html;355.91102224443887;359.9100224943764;362.87843572403244;363.4856677800912;364.8558819266388;14143.434262629507;14240.216788076652;16553.83446165538;16968.49094527163;17611.207495662693;13319.933400332984;14156.929215353935;16028.278727457264;16717.414890478834;16768.41310554131;5401.78392864285;5570.693611851347;5571.774209673866;5575.303087114111;5580.079286917674;3978.701597380208;4020.5376381716037;5538.418466061066;5580.441955804407;5889.322727886283;5954.583179177459;5979.880402391949;5984.251968503937;5988.490978266853;5990.6106103103375;4993.051320249141;5140.203268493389;5154.587632989352;5170.276161337416;5962.34414214436;4960.131976904027;4961.677490963076;4984.102861484931;5056.721880296583;5244.711540865251;19573.412797616093;19611.313604023933;19962.70055949162;20014.09936552844;20032.899835500873;2013.8993050347572;2088.4778805298674;2111.514351699118;2244;2357.0807385119647;9189.724308270763;9199.494027828467;9264.768380790467;12089.879101208964;12928.246940030547;1771.8936863788085;1789.168036862852;1803.1705415508882;1808.2405389736343;1891.5649400637792;56071.719641401534;57597;62092;64125.35874641241;65405.672971634835;9092.818143637223;9532.618695252251;10012.64955726546;10067.949660251652;10163.44101074448;13330.800037999437;13359.265240411676;13379;13381.264030478416;13389.330533473481;7474.551526908403;7506.662200201004;7507.887381689279;7518.173000969889;7568.394528437711;7170.677319520634;7210.206877243499;7226.349628533457;7255.927440725631;7263.782086537412;4241.87274381769;4293.0769884474985;4413.16149931512;4417.469903611587;4455.2648812946145;1721.3028723367056;1743.651269746056;1757.8417942385247;1770.2299499717665;1793.390247315919;922.2529750901791;939.2767568971854;988.9406635601887;989.1839232633107;994.5176589354157;16110.919445402933;16773.83226167747;17157.914210429117;17406.91296543509;17700.9114954427;892.2638822971074;931.4364809290417;937.5734041011324;949.1457688080644;997.7405874472689;7736.458447908705;9760.560774765152;9769.706908792748;9780.168685661798;9792.21662267017;520723;522915;524312;549740;558576;76175.61912190403;79710;80145.59927200443;80187;80742;1101.7465982823996;1102.3606308341143;1110.6168371911679;1114.6934592986831;1116.3413585984147;15093.622659433162;15171.468998584996;15223;15227.238638068275;15651.139187344805;35230;35569.46645800264;35633.1091722709;37098.44352334663;39503.80248098741;47453.288200676325;47557;48184.27723584079;50565.74717126391;52614.210786837466;14559.85440145585;14865.182414966848;14936.477223297132;15107.32017059257;15133.54599362021;10639.361638301418;10893.400862952614;10903.091958907318;10967.341959482457;11015.449227538431;8572.314214862672;8607.65569377218;9866.654667086617;9926.354786938826;10022.098011179029;9623.278254131108;9926.602935882484;9999.850002250118;10047.949760251153;10365.274430789772;8338.833223335621;9471.47906865129;9925.1067403934;9967.302288839712;10145.442000690033;14768.556943291718;14896.702065958403;15061.47284845069;15084.170370629721;15131.092134471966;14326.856731432968;14338;14998.175100369584;15475.613109672347;15820.28808703588 19:08:01 INFO - 2015-11-20 19:08:01,790 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1009.5053423822329;1722.6382459683464;1777.5467255849765;1786.9106544672763;1804.891706497611;6646.501512386566;7299.4890357674985;7423.700852350844;7431.739889103883;7434.442416818733;7323.816904577388;7482.700691972328;7512.286332798389;7514.0607424071995;7520;1951.7267582538457;1975.2790231565448;1975.3777560068531;2250.223672832874;2277.464795772992;2250.1224522436264;2283.6917016202765;2284.794368506834;2285.919992800252;2288.107638021173;2185.1259496201487;2210.0386331945656;2264.728232612089;2280.5894938910988;2285.6571514272828;1921.634889371022;1952.1020330647848;1953.7557805274341;1954.257382194771;2242.3385101395047;1968.4094771568473;2202.3392982105465;2234.4190510467233;2234.971912920059;2236.1837929155904;7521.811954701122;7554.206808285161;7615.428842836754;7621.466497345188;7632.732854350126;4532.750698711569;4541.931871021938;4588.541145885418;4606.470255920579;4613.907721845578;3003.9399212015855;3005.1285127313054;3099.209701526119;3103.7827352085365;3104.9689503105133;962.3119469579215;965.956766691971;976.5947131940236;988.7478692933256;1011.5043628621922;10341.586336546528;10355.89644103557;10412;10420.895791042145;10423.114035307008;4134.462519872397;4181.519125300569;4196.265653510684;4238.87283381499;4247.51153617338;8941.59762810675;8951;8952.104789521127;8952.8657070144;8961.462312261285;4661.324108004321;4679.461861885927;4694.577488026094;4695.060987802453;4696.718196908197;4216.47294088239;4224.91550169001;4235.025944032828;4236.703430759817;4241.745495270232;3572.8749493767596;3602.4776407420777;3605.3149901518627;3616.403293456603;3640.7997560134445;1164.8660404053473;1169.8128299472044;1170.0931777872047;1172.4489489939715;1174.0372894226653;1263.91784534005;1272.1985149356033;1302.7785276503016;1340.825692659948;1341.2824139085542;7120.572765634079;7140.107486564179;7185.173705023884;7186.532875363085;7214.350708436266;455.5490064835855;456.6940150099441;456.8789270843229;465.37407187332985;477.5678011399689;5165.9483405165465;5296.04671159195;5452.018636645442;5502.8349149525575;5602.299712535933;8852.513111778913;9090.181883630505;9135.725928222164;9143.03998080192;9147.54262286883;8859.64561417549;8930.19628233462;9252.352335336596;9262.16640502358;9275.25797936177;7072.92927070733;7144.714211431588;7157.176924653628;7203.351698347174;7205.675744591506;7021.1574611047;7192.784216473514;7200;7203.8919416207755;7205.819854503679;7839.098503671923;8090.595470226347;8128.105908349959;8139.79650508742;8262.628181731716;8313.33493320545;8373.539455330016;8395.202455766692;8415.95792021036;8503.362247831314;6872.41584465306;6933.5493192942295;6943.201531823703;6944.652767361511;6953.443724501926;7194.388476979515;7277.636118194175;7286.744963926237;7322.0115284435915;7349.412047036331;6984.4761642878;7049.682764275517;7125.964370178116;7138.321859423347;7156.3917067047805;6849.828754280983;6861.142357205349;6901;7034.683439245348;7036.36672699439;6933.687984040629;6967.442604591722;6984.895226571504;6991.161060672752;7010.053642758367;6203.286622038523;6277.435030847246;6319.3364696706185;6336.366363363627;6348.016057511093;6339.112524246517;6359.936400635935;6376.39424254695;6378.33027532121;6386.87226255463 19:08:01 INFO - 2015-11-20 19:08:01,790 DEBUG : BROWSER_OUTPUT: |4;prototype.html;314.39792796794137;315.9682451913582;317.11999202213855;321.0689001894504;324.9707526322631;5877.9118313225335;5983.970080149598;6021.157038014681;6063.242094738158;6074.726637301321;5827.796027139051;5917.585768996172;6001.279846418436;6014.699265036742;6016.2479690038745;4369;4576.244919588272;4606.286025666011;4610.700304480215;4615.030843522864;4482.282834746425;4504.481984571784;4504.932426013613;4505.414296141497;4551.340055691922;4549.567791059844;4576.8626941191815;4584.885377865563;4595.379623750801;4600.861974140765;4571.771411429432;4576.107659006479;4578.336141259532;4582.473015603215;4585.449746030497;4010.5588385277597;4011.0774521860135;4012;4016.9957510622344;4026.375911733686;5550.666959982374;5659.377468478464;5692.57305702074;5724.055530837407;5727.3699893011735;5286.15421532553;5314.309139811839;5323.680579165262;5333.973330133364;5337.786488540453;6365.809025729235;6381.138546296237;6381.8085457436355;6381.968090159519;6384.3296453872135;4320.546342634009;4324.891877703051;4439.489458712257;4444.688871778977;4444.711093778927;6624.6025238485845;6626.436752876011;6635.635040072794;6635.9336406636285;6636.435902948255;4516.36770852081;4540.682152249311;4543.477500087466;4544.818207271672;4545.2954792007295;4597.287420449836;4597.609203217697;4599.2871104978785;4600.033992861537;4605.930911036337;5091.9236211456855;5234.869128271824;5241.895162096736;5243.842684719464;5317.548008419328;6456.7740129095255;6460.386263305072;6463.192100987377;6466.159399278064;6474.9963755617955;1563.4059057558054;1578.7237233484095;1579.7946266985218;1581.6283173454228;1582.0586750883435;1022.5449674894601;1029.53156313877;1037.9740506487246;1041.9479026048666;1054.2198772908146;6131.50947924165;6174.289956654952;6184.288806787277;6194.473469755121;6199;6414.903776443357;6590.472762179014;6613.470922326299;6616.14747870597;6618.371254730793;6117.480014198754;6171.290301615282;6235.625862448268;6283.748650053946;6291.653959032205;3556.8577256909953;3562.6437356264164;3563.2339047104997;3586.964130358663;3588.4617307404096;6683.832904177337;6774.42417394527;6873.862522749517;6877.793666190022;6881.483888708267;6833.726650934006;6864.931350686529;6873;6874.621895795679;6876.106106206261;6768.390844823989;6774.491913106537;6775.390214880685;6780;6784.660766961632;6547.051630773762;6646.966765166143;6685.799426017227;6689.397954184147;6699.497537684596;6598.1422415085735;6606.8348291293105;6625.039369291329;6626.966865165643;6636.800895973129;6876.793696189123;6878.55289406187;6879.828004299932;6888.242293347627;6892.896606550806;4371.453568303962;4486.64106871443;4487.237169681227;4492;4496.842610508616;6442.291347951816;6446.774362897276;6451.838704032437;6453.1610890583925;6456.580322279036;6301.779437719658;6322.178116844781;6337.302896681269;6338.841528961812;6340;6180.412860778219;6307.117003619405;6331.90502142459;6340.651264180515;6348.746050157942;6167.660778657038;6172.907406388818;6176.722047507963;6177.949748542668;6180.289266734203;6296.811095667137;6342.334054924351;6352.618842869442;6360.618362898241;6365.745370185141;6018.337982821974;6083.7870674526175;6122.510199183966;6152.384761523812;6219.751209951733 19:08:01 INFO - 2015-11-20 19:08:01,791 DEBUG : BROWSER_OUTPUT: |5;yui.html;766.5017738469994;832.9042160151581;841.1672444280165;862.9956850215748;864.2740098317412;13901;14069;14157.575272741808;14175.149491030545;14185.78721319181;13185.802212966813;13294.534691285808;13304.135231209988;13305.933470332659;13330.200187988727;683.111954459201;688.3770187979886;821.1583127294541;836.1471299274751;836.9874451883196;835.419383528448;844.5903736687701;845.3490812074699;847.4533925618003;850.0691742541937;721.8195451137216;889.728632767009;894.4007514964957;894.4275663575316;895.5566994337812;723.4718655381574;870.268974061788;884.460479107747;885.0353115104567;885.9955700221523;653.3042309939899;653.5490511547017;654.1496055128362;654.3554598720257;654.9410553050249;13355.599332020054;13466.25935573543;13552.119112257671;13572.45710171592;13579;12554.874451255462;12876.163049401759;13122.14706044104;13175.814176724141;13477.460901563925;10318.535665894977;10457.633982810565;10522.526486308134;10538.894611053867;10563.524641391155;3608.783472991629;3610.855565777366;3618;3677.4667673187237;3783.754055986352;46265.5373446268;46302.305465418045;46413.30380044302;46418;46693.29960050602;9701.272404569545;9748.366356186825;9839.80320393588;9873.901260987443;10155.441450720133;18386.540336491427;18481.353152639862;18483.16825742845;18485.63028739418;18487;7249.238829922782;7470.402367810562;7600.695972161162;7654.96172519145;7681.155072941972;4200.199962383304;4298.075913678574;4353.869383918487;4369.781510924505;4431.313146462304;3104.891328803526;3155.8422078895965;3173.444647186733;3181.2524056846623;3181.459151944175;526.4261954469647;531.8936212757386;537.6317222702461;540.5810496864882;542.5090293284584;621.3413781391739;629.3580547841176;639.9392057754505;654.3816093791321;684.3703792510902;8802.691905783267;8819.29445644347;8893.110688931185;8902.376833621584;8979;501.8218532421011;516.354556803995;572.7537159021578;698.6297262450909;716.8244079709281;4004.799760011988;4055.3308704063497;4223.155368926227;4353.499347575006;4448.288273876165;56917.43082569121;57739.711301443225;58015;58104;58184.12723809146;49247.105405243296;49567.50432495629;50039.24941125886;50507.24239136416;50881;46046.079078418246;46096;47266.5273347269;47695.28457073147;47975.76012119917;8978.86531702038;9051.366404351633;9248.260139188715;9290;9434.48110353937;35551.46672799858;35641.46537801883;36225;36410.45384319184;37042.62957370392;44395.33406998833;44687.329690055325;44809.327860081474;45559.31661025154;45927.54072459233;10836.945815270874;10942.562297508011;11521.942390287995;11532.769344613229;11668.591599293984;12593.181443206162;12633.810492842798;12798.16811907223;12888.484460621845;13348.666283342995;11379.658610241706;11731.530738770694;12000.099992500773;12095.879041209475;12359.814602780785;11048.723781905517;11280.717982050515;11561.768764624829;11654.242474239147;11990.760184796429;10498.265121441731;10866.945665271624;11044.392558409043;11217.158713096387;12102.394880255775;9302.488363140092;9434;9439.339246252697;9976.60093596277;10084.142847858015;8897.199252067345;9064.818703626022;9469.952650236704;9471.579263110589;9939.850902236616 19:08:01 INFO - 2015-11-20 19:08:01,791 DEBUG : BROWSER_OUTPUT: __end_tp_report 19:08:01 INFO - 2015-11-20 19:08:01,791 DEBUG : BROWSER_OUTPUT: __start_cc_report 19:08:01 INFO - 2015-11-20 19:08:01,791 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,974 19:08:01 INFO - 2015-11-20 19:08:01,791 DEBUG : BROWSER_OUTPUT: __end_cc_report 19:08:01 INFO - 2015-11-20 19:08:01,791 DEBUG : BROWSER_OUTPUT: __startTimestamp1448075281783__endTimestamp 19:08:01 INFO - 2015-11-20 19:08:01,791 DEBUG : BROWSER_OUTPUT: 19:08:01 INFO - 2015-11-20 19:08:01,791 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 19:08:01 INFO - 2015-11-20 19:08:01,791 DEBUG : BROWSER_OUTPUT: Number of tests: 6 19:08:01 INFO - 2015-11-20 19:08:01,791 DEBUG : BROWSER_OUTPUT: 19:08:01 INFO - 2015-11-20 19:08:01,791 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:5407.26 Median:5600.55 stddev:601.47 (10.7%) stddev-sans-first:575.77 19:08:01 INFO - 2015-11-20 19:08:01,792 DEBUG : BROWSER_OUTPUT: Values: 3113.8 3225.8 3268.1 3277.1 3299.2 5242.1 5332.4 5371.3 5419.0 5513.1 5323.9 5341.1 5351.3 5357.1 5416.9 4896.9 4974.3 5002.6 5022.5 5066.2 4733.8 4973.2 4983.4 5024.6 5059.2 4848.6 4874.3 4918.5 4947.7 4955.2 4929.7 4931.3 4940.5 4948.2 4977.4 4818.3 4920.9 4938.2 4944.6 4966.6 5175.5 5245.5 5341.3 5353.8 5368.0 5902.9 5910.0 5914.0 5919.8 5920.2 5741.1 5844.2 5944.3 5949.5 5951.8 5452.9 5528.8 5573.5 5591.5 5593.1 5898.6 5912.2 5922.6 5935.5 5962.6 5624.0 5795.3 5809.5 5845.9 5852.3 5653.8 5710.6 5720.6 5795.7 5868.3 5782.0 5833.7 5837.4 5842.2 5845.0 5584.8 5811.5 5822.2 5826.7 5834.6 4456.9 4458.5 4471.7 4530.3 4556.6 3994.0 4006.3 4024.4 4027.1 4066.4 5590.5 5591.6 5600.6 5601.1 5626.6 5547.3 5690.3 5723.8 5878.5 5894.1 5587.9 5598.7 5601.6 5602.0 5620.0 4955.9 4956.0 4964.1 4967.2 5014.0 5794.1 5801.6 5810.2 5993.9 6099.9 5815.6 5845.6 5888.9 5891.9 5895.9 6010.8 6017.4 6025.6 6036.3 6038.7 5641.5 5646.3 5700.5 5732.3 5836.1 5823.5 5836.8 5838.3 5840.1 5856.5 5773.0 5783.0 5784.4 5800.1 5806.6 5531.9 5598.7 5650.5 5663.5 5721.9 5563.5 5569.4 5575.4 5577.6 5578.2 5690.4 5712.2 5737.2 5746.6 5758.2 5417.3 5506.0 5517.6 5539.6 5676.4 19:08:01 INFO - 2015-11-20 19:08:01,793 DEBUG : BROWSER_OUTPUT: 19:08:01 INFO - 2015-11-20 19:08:01,793 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:45184.50 Median:169482.27 stddev:74644.15 (44.0%) stddev-sans-first:74778.36 19:08:01 INFO - 2015-11-20 19:08:01,793 DEBUG : BROWSER_OUTPUT: Values: 563.1 613.9 616.8 618.4 619.9 32095.8 39822.0 40218.6 40224.2 40243.6 42219.6 42614.8 42650.8 42768.6 42798.0 7679.6 7810.0 8700.7 8858.6 8921.6 7635.6 7714.1 10507.2 10734.5 10738.7 10433.6 10555.2 10560.2 10563.4 10563.7 7808.0 10367.7 10449.5 10459.2 10466.7 7656.0 10079.5 10357.2 10364.8 10378.1 36162.3 36573.0 36624.3 36645.5 36705.1 3280.6 3319.3 3327.1 3420.3 3436.7 29725.6 30352.0 30476.5 30906.5 31748.2 3252.8 3271.6 3289.1 3411.4 3414.9 276944.0 277477.0 277671.0 278224.0 278641.0 54280.0 55166.7 55491.4 55721.4 56270.2 53627.0 54206.5 54370.5 54607.0 54683.5 14812.1 14998.9 15011.6 15028.5 15033.3 11458.0 11473.9 11519.4 11535.4 11543.4 18048.6 18621.0 18804.9 18882.8 18937.0 7647.2 7739.7 7931.3 7981.5 8015.8 935.5 978.8 984.5 1002.3 1088.7 24997.3 25022.4 26916.3 27276.3 27451.0 1028.4 1065.9 1066.5 1075.0 1159.2 14302.7 14349.3 14355.6 14484.2 14520.8 302189.0 306530.0 307070.0 307343.0 307474.0 53244.5 53477.2 53568.0 53598.5 53610.7 1324.0 1326.8 1342.7 1343.9 1345.1 27046.7 27513.4 27791.4 27951.0 28084.0 42492.6 45374.5 45701.5 45773.5 45807.0 215956.0 217040.0 297838.0 308035.0 308058.0 29392.4 29554.0 29639.0 29716.0 29730.4 40581.4 42848.4 43311.0 43897.3 44033.1 37297.0 37377.8 37509.4 38645.6 38705.8 35547.1 35609.3 36466.3 36659.0 36843.1 33617.5 33639.8 33646.2 35755.5 36090.6 29204.6 30286.5 30545.0 30593.0 30594.7 24824.5 25013.4 25114.1 25309.4 25501.0 19:08:01 INFO - 2015-11-20 19:08:01,793 DEBUG : BROWSER_OUTPUT: 19:08:01 INFO - 2015-11-20 19:08:01,795 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:28552.29 Median:4131.21 stddev:87559.04 (2119.5%) stddev-sans-first:87779.07 19:08:01 INFO - 2015-11-20 19:08:01,796 DEBUG : BROWSER_OUTPUT: Values: 355.9 359.9 362.9 363.5 364.9 14143.4 14240.2 16553.8 16968.5 17611.2 13319.9 14156.9 16028.3 16717.4 16768.4 5401.8 5570.7 5571.8 5575.3 5580.1 3978.7 4020.5 5538.4 5580.4 5889.3 5954.6 5979.9 5984.3 5988.5 5990.6 4993.1 5140.2 5154.6 5170.3 5962.3 4960.1 4961.7 4984.1 5056.7 5244.7 19573.4 19611.3 19962.7 20014.1 20032.9 2013.9 2088.5 2111.5 2244.0 2357.1 9189.7 9199.5 9264.8 12089.9 12928.2 1771.9 1789.2 1803.2 1808.2 1891.6 56071.7 57597.0 62092.0 64125.4 65405.7 9092.8 9532.6 10012.6 10067.9 10163.4 13330.8 13359.3 13379.0 13381.3 13389.3 7474.6 7506.7 7507.9 7518.2 7568.4 7170.7 7210.2 7226.3 7255.9 7263.8 4241.9 4293.1 4413.2 4417.5 4455.3 1721.3 1743.7 1757.8 1770.2 1793.4 922.3 939.3 988.9 989.2 994.5 16110.9 16773.8 17157.9 17406.9 17700.9 892.3 931.4 937.6 949.1 997.7 7736.5 9760.6 9769.7 9780.2 9792.2 520723.0 522915.0 524312.0 549740.0 558576.0 76175.6 79710.0 80145.6 80187.0 80742.0 1101.7 1102.4 1110.6 1114.7 1116.3 15093.6 15171.5 15223.0 15227.2 15651.1 35230.0 35569.5 35633.1 37098.4 39503.8 47453.3 47557.0 48184.3 50565.7 52614.2 14559.9 14865.2 14936.5 15107.3 15133.5 10639.4 10893.4 10903.1 10967.3 11015.4 8572.3 8607.7 9866.7 9926.4 10022.1 9623.3 9926.6 9999.9 10047.9 10365.3 8338.8 9471.5 9925.1 9967.3 10145.4 14768.6 14896.7 15061.5 15084.2 15131.1 14326.9 14338.0 14998.2 15475.6 15820.3 19:08:01 INFO - 2015-11-20 19:08:01,796 DEBUG : BROWSER_OUTPUT: 19:08:01 INFO - 2015-11-20 19:08:01,796 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5327.88 Median:6343.56 stddev:2779.42 (43.8%) stddev-sans-first:2768.26 19:08:01 INFO - 2015-11-20 19:08:01,797 DEBUG : BROWSER_OUTPUT: Values: 1009.5 1722.6 1777.5 1786.9 1804.9 6646.5 7299.5 7423.7 7431.7 7434.4 7323.8 7482.7 7512.3 7514.1 7520.0 1951.7 1975.3 1975.4 2250.2 2277.5 2250.1 2283.7 2284.8 2285.9 2288.1 2185.1 2210.0 2264.7 2280.6 2285.7 1921.6 1952.1 1953.8 1954.3 2242.3 1968.4 2202.3 2234.4 2235.0 2236.2 7521.8 7554.2 7615.4 7621.5 7632.7 4532.8 4541.9 4588.5 4606.5 4613.9 3003.9 3005.1 3099.2 3103.8 3105.0 962.3 966.0 976.6 988.7 1011.5 10341.6 10355.9 10412.0 10420.9 10423.1 4134.5 4181.5 4196.3 4238.9 4247.5 8941.6 8951.0 8952.1 8952.9 8961.5 4661.3 4679.5 4694.6 4695.1 4696.7 4216.5 4224.9 4235.0 4236.7 4241.7 3572.9 3602.5 3605.3 3616.4 3640.8 1164.9 1169.8 1170.1 1172.4 1174.0 1263.9 1272.2 1302.8 1340.8 1341.3 7120.6 7140.1 7185.2 7186.5 7214.4 455.5 456.7 456.9 465.4 477.6 5165.9 5296.0 5452.0 5502.8 5602.3 8852.5 9090.2 9135.7 9143.0 9147.5 8859.6 8930.2 9252.4 9262.2 9275.3 7072.9 7144.7 7157.2 7203.4 7205.7 7021.2 7192.8 7200.0 7203.9 7205.8 7839.1 8090.6 8128.1 8139.8 8262.6 8313.3 8373.5 8395.2 8416.0 8503.4 6872.4 6933.5 6943.2 6944.7 6953.4 7194.4 7277.6 7286.7 7322.0 7349.4 6984.5 7049.7 7126.0 7138.3 7156.4 6849.8 6861.1 6901.0 7034.7 7036.4 6933.7 6967.4 6984.9 6991.2 7010.1 6203.3 6277.4 6319.3 6336.4 6348.0 6339.1 6359.9 6376.4 6378.3 6386.9 19:08:01 INFO - 2015-11-20 19:08:01,797 DEBUG : BROWSER_OUTPUT: 19:08:01 INFO - 2015-11-20 19:08:01,798 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:5324.91 Median:6079.26 stddev:1619.01 (26.6%) stddev-sans-first:1579.27 19:08:01 INFO - 2015-11-20 19:08:01,799 DEBUG : BROWSER_OUTPUT: Values: 314.4 316.0 317.1 321.1 325.0 5877.9 5984.0 6021.2 6063.2 6074.7 5827.8 5917.6 6001.3 6014.7 6016.2 4369.0 4576.2 4606.3 4610.7 4615.0 4482.3 4504.5 4504.9 4505.4 4551.3 4549.6 4576.9 4584.9 4595.4 4600.9 4571.8 4576.1 4578.3 4582.5 4585.4 4010.6 4011.1 4012.0 4017.0 4026.4 5550.7 5659.4 5692.6 5724.1 5727.4 5286.2 5314.3 5323.7 5334.0 5337.8 6365.8 6381.1 6381.8 6382.0 6384.3 4320.5 4324.9 4439.5 4444.7 4444.7 6624.6 6626.4 6635.6 6635.9 6636.4 4516.4 4540.7 4543.5 4544.8 4545.3 4597.3 4597.6 4599.3 4600.0 4605.9 5091.9 5234.9 5241.9 5243.8 5317.5 6456.8 6460.4 6463.2 6466.2 6475.0 1563.4 1578.7 1579.8 1581.6 1582.1 1022.5 1029.5 1038.0 1041.9 1054.2 6131.5 6174.3 6184.3 6194.5 6199.0 6414.9 6590.5 6613.5 6616.1 6618.4 6117.5 6171.3 6235.6 6283.7 6291.7 3556.9 3562.6 3563.2 3587.0 3588.5 6683.8 6774.4 6873.9 6877.8 6881.5 6833.7 6864.9 6873.0 6874.6 6876.1 6768.4 6774.5 6775.4 6780.0 6784.7 6547.1 6647.0 6685.8 6689.4 6699.5 6598.1 6606.8 6625.0 6627.0 6636.8 6876.8 6878.6 6879.8 6888.2 6892.9 4371.5 4486.6 4487.2 4492.0 4496.8 6442.3 6446.8 6451.8 6453.2 6456.6 6301.8 6322.2 6337.3 6338.8 6340.0 6180.4 6307.1 6331.9 6340.7 6348.7 6167.7 6172.9 6176.7 6177.9 6180.3 6296.8 6342.3 6352.6 6360.6 6365.7 6018.3 6083.8 6122.5 6152.4 6219.8 19:08:01 INFO - 2015-11-20 19:08:01,799 DEBUG : BROWSER_OUTPUT: 19:08:01 INFO - 2015-11-20 19:08:01,799 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:13904.80 Median:46357.80 stddev:15878.54 (34.3%) stddev-sans-first:15892.43 19:08:01 INFO - 2015-11-20 19:08:01,799 DEBUG : BROWSER_OUTPUT: Values: 766.5 832.9 841.2 863.0 864.3 13901.0 14069.0 14157.6 14175.1 14185.8 13185.8 13294.5 13304.1 13305.9 13330.2 683.1 688.4 821.2 836.1 837.0 835.4 844.6 845.3 847.5 850.1 721.8 889.7 894.4 894.4 895.6 723.5 870.3 884.5 885.0 886.0 653.3 653.5 654.1 654.4 654.9 13355.6 13466.3 13552.1 13572.5 13579.0 12554.9 12876.2 13122.1 13175.8 13477.5 10318.5 10457.6 10522.5 10538.9 10563.5 3608.8 3610.9 3618.0 3677.5 3783.8 46265.5 46302.3 46413.3 46418.0 46693.3 9701.3 9748.4 9839.8 9873.9 10155.4 18386.5 18481.4 18483.2 18485.6 18487.0 7249.2 7470.4 7600.7 7655.0 7681.2 4200.2 4298.1 4353.9 4369.8 4431.3 3104.9 3155.8 3173.4 3181.3 3181.5 526.4 531.9 537.6 540.6 542.5 621.3 629.4 639.9 654.4 684.4 8802.7 8819.3 8893.1 8902.4 8979.0 501.8 516.4 572.8 698.6 716.8 4004.8 4055.3 4223.2 4353.5 4448.3 56917.4 57739.7 58015.0 58104.0 58184.1 49247.1 49567.5 50039.2 50507.2 50881.0 46046.1 46096.0 47266.5 47695.3 47975.8 8978.9 9051.4 9248.3 9290.0 9434.5 35551.5 35641.5 36225.0 36410.5 37042.6 44395.3 44687.3 44809.3 45559.3 45927.5 10836.9 10942.6 11521.9 11532.8 11668.6 12593.2 12633.8 12798.2 12888.5 13348.7 11379.7 11731.5 12000.1 12095.9 12359.8 11048.7 11280.7 11561.8 11654.2 11990.8 10498.3 10866.9 11044.4 11217.2 12102.4 9302.5 9434.0 9439.3 9976.6 10084.1 8897.2 9064.8 9470.0 9471.6 9939.9 19:08:01 INFO - 2015-11-20 19:08:01,799 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 19:08:01 INFO - 2015-11-20 19:08:01,799 DEBUG : BROWSER_OUTPUT: 19:08:02 INFO - 2015-11-20 19:08:02,482 INFO : Browser exited with error code: 0 19:08:02 INFO - 2015-11-20 19:08:02,500 INFO : Completed test dromaeo_css (00:18:33) 19:08:02 INFO - 2015-11-20 19:08:02,500 INFO : Starting test kraken 19:08:02 INFO - 2015-11-20 19:08:02,500 DEBUG : operating with platform_type : linux_ 19:08:02 INFO - 2015-11-20 19:08:02,500 INFO : Initialising browser for kraken test... 19:08:02 INFO - 2015-11-20 19:08:02,507 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpUmVyDd/profile http://localhost:53774/getInfo.html 19:08:06 INFO - 2015-11-20 19:08:06,391 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 19:08:06 INFO - 2015-11-20 19:08:06,391 DEBUG : BROWSER_OUTPUT: colorDepth:24 19:08:06 INFO - 2015-11-20 19:08:06,392 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 19:08:06 INFO - 2015-11-20 19:08:06,392 DEBUG : BROWSER_OUTPUT: __metrics 19:08:06 INFO - 2015-11-20 19:08:06,561 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:08:07 INFO - 2015-11-20 19:08:07,776 INFO : Browser initialized. 19:08:07 INFO - 2015-11-20 19:08:07,776 INFO : Running cycle 1/1 for kraken test... 19:08:07 INFO - 2015-11-20 19:08:07,776 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpUmVyDd/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 19:08:19 INFO - 2015-11-20 19:08:19,593 DEBUG : BROWSER_OUTPUT: RSS: Main: 142245888 19:08:19 INFO - 2015-11-20 19:08:19,593 DEBUG : BROWSER_OUTPUT: 19:08:22 INFO - 2015-11-20 19:08:22,102 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53774/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:53774/tests/kraken/driver.html?testName=audio-beat-detection) 19:08:22 INFO - 2015-11-20 19:08:22,676 DEBUG : BROWSER_OUTPUT: RSS: Main: 179093504 19:08:22 INFO - 2015-11-20 19:08:22,676 DEBUG : BROWSER_OUTPUT: 19:08:25 INFO - 2015-11-20 19:08:25,273 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53774/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:53774/tests/kraken/driver.html?testName=audio-dft) 19:08:25 INFO - 2015-11-20 19:08:25,859 DEBUG : BROWSER_OUTPUT: RSS: Main: 168304640 19:08:25 INFO - 2015-11-20 19:08:25,859 DEBUG : BROWSER_OUTPUT: 19:08:28 INFO - 2015-11-20 19:08:28,718 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53774/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:53774/tests/kraken/driver.html?testName=audio-fft) 19:08:29 INFO - 2015-11-20 19:08:29,279 DEBUG : BROWSER_OUTPUT: RSS: Main: 150278144 19:08:29 INFO - 2015-11-20 19:08:29,279 DEBUG : BROWSER_OUTPUT: 19:08:31 INFO - 2015-11-20 19:08:31,243 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53774/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:53774/tests/kraken/driver.html?testName=audio-oscillator) 19:08:31 INFO - 2015-11-20 19:08:31,804 DEBUG : BROWSER_OUTPUT: RSS: Main: 153235456 19:08:31 INFO - 2015-11-20 19:08:31,804 DEBUG : BROWSER_OUTPUT: 19:08:33 INFO - 2015-11-20 19:08:33,964 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53774/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:53774/tests/kraken/driver.html?testName=imaging-gaussian-blur) 19:08:34 INFO - 2015-11-20 19:08:34,526 DEBUG : BROWSER_OUTPUT: RSS: Main: 156426240 19:08:34 INFO - 2015-11-20 19:08:34,527 DEBUG : BROWSER_OUTPUT: 19:08:37 INFO - 2015-11-20 19:08:37,445 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53774/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:53774/tests/kraken/driver.html?testName=imaging-darkroom) 19:08:38 INFO - 2015-11-20 19:08:38,024 DEBUG : BROWSER_OUTPUT: RSS: Main: 155172864 19:08:38 INFO - 2015-11-20 19:08:38,025 DEBUG : BROWSER_OUTPUT: 19:08:41 INFO - 2015-11-20 19:08:41,394 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53774/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:53774/tests/kraken/driver.html?testName=imaging-desaturate) 19:08:41 INFO - 2015-11-20 19:08:41,968 DEBUG : BROWSER_OUTPUT: RSS: Main: 156696576 19:08:41 INFO - 2015-11-20 19:08:41,968 DEBUG : BROWSER_OUTPUT: 19:08:44 INFO - 2015-11-20 19:08:44,733 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53774/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:53774/tests/kraken/driver.html?testName=json-parse-financial) 19:08:45 INFO - 2015-11-20 19:08:45,315 DEBUG : BROWSER_OUTPUT: RSS: Main: 156958720 19:08:45 INFO - 2015-11-20 19:08:45,316 DEBUG : BROWSER_OUTPUT: 19:08:46 INFO - 2015-11-20 19:08:46,893 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53774/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:53774/tests/kraken/driver.html?testName=json-stringify-tinderbox) 19:08:47 INFO - 2015-11-20 19:08:47,454 DEBUG : BROWSER_OUTPUT: RSS: Main: 166006784 19:08:47 INFO - 2015-11-20 19:08:47,454 DEBUG : BROWSER_OUTPUT: 19:08:49 INFO - 2015-11-20 19:08:49,252 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53774/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:53774/tests/kraken/driver.html?testName=stanford-crypto-aes) 19:08:49 INFO - 2015-11-20 19:08:49,854 DEBUG : BROWSER_OUTPUT: RSS: Main: 165863424 19:08:49 INFO - 2015-11-20 19:08:49,854 DEBUG : BROWSER_OUTPUT: 19:08:51 INFO - 2015-11-20 19:08:51,890 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53774/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:53774/tests/kraken/driver.html?testName=stanford-crypto-ccm) 19:08:52 INFO - 2015-11-20 19:08:52,463 DEBUG : BROWSER_OUTPUT: RSS: Main: 171765760 19:08:52 INFO - 2015-11-20 19:08:52,463 DEBUG : BROWSER_OUTPUT: 19:08:54 INFO - 2015-11-20 19:08:54,868 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53774/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:53774/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 19:08:55 INFO - 2015-11-20 19:08:55,450 DEBUG : BROWSER_OUTPUT: RSS: Main: 180682752 19:08:55 INFO - 2015-11-20 19:08:55,450 DEBUG : BROWSER_OUTPUT: 19:08:57 INFO - 2015-11-20 19:08:57,978 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53774/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:53774/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 19:08:58 INFO - 2015-11-20 19:08:58,551 DEBUG : BROWSER_OUTPUT: RSS: Main: 177541120 19:08:58 INFO - 2015-11-20 19:08:58,551 DEBUG : BROWSER_OUTPUT: 19:09:00 INFO - 2015-11-20 19:09:00,204 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53774/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:53774/tests/kraken/driver.html?testName=ai-astar) 19:09:00 INFO - 2015-11-20 19:09:00,454 DEBUG : BROWSER_OUTPUT: RSS: Main: 236003328 19:09:00 INFO - 2015-11-20 19:09:00,454 DEBUG : BROWSER_OUTPUT: 19:09:00 INFO - 2015-11-20 19:09:00,455 DEBUG : BROWSER_OUTPUT: __start_tp_report 19:09:00 INFO - 2015-11-20 19:09:00,456 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 19:09:00 INFO - 2015-11-20 19:09:00,456 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 19:09:00 INFO - 2015-11-20 19:09:00,456 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 19:09:00 INFO - 2015-11-20 19:09:00,456 DEBUG : BROWSER_OUTPUT: |0;ai-astar;109;110;103;110;110;110;102;110;109;107 19:09:00 INFO - 2015-11-20 19:09:00,456 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;155;124;149;166;130;153;155;126;162;127 19:09:00 INFO - 2015-11-20 19:09:00,456 DEBUG : BROWSER_OUTPUT: |2;audio-dft;161;161;160;161;161;160;160;162;162;160 19:09:00 INFO - 2015-11-20 19:09:00,456 DEBUG : BROWSER_OUTPUT: |3;audio-fft;72;73;80;90;72;73;73;108;102;72 19:09:00 INFO - 2015-11-20 19:09:00,456 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;90;91;148;90;90;91;133;91;90;140 19:09:00 INFO - 2015-11-20 19:09:00,456 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;110;109;110;110;109;110;109;109;109;109 19:09:00 INFO - 2015-11-20 19:09:00,456 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;146;145;146;147;146;145;146;145;148;145 19:09:00 INFO - 2015-11-20 19:09:00,456 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;95;95;95;95;96;96;96;96;95;96 19:09:00 INFO - 2015-11-20 19:09:00,456 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;59;60;59;60;61;59;59;68;56;65 19:09:00 INFO - 2015-11-20 19:09:00,456 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;69;70;69;70;70;70;70;70;70;69 19:09:00 INFO - 2015-11-20 19:09:00,456 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;83;83;83;84;85;83;84;92;84;83 19:09:00 INFO - 2015-11-20 19:09:00,457 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;120;112;119;122;125;117;120;125;118;132 19:09:00 INFO - 2015-11-20 19:09:00,457 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;138;139;149;148;165;140;153;148;146;140 19:09:00 INFO - 2015-11-20 19:09:00,457 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;65;72;66;66;67;65;68;67;66;66 19:09:00 INFO - 2015-11-20 19:09:00,457 DEBUG : BROWSER_OUTPUT: __end_tp_report 19:09:00 INFO - 2015-11-20 19:09:00,457 DEBUG : BROWSER_OUTPUT: __start_cc_report 19:09:00 INFO - 2015-11-20 19:09:00,457 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,939 19:09:00 INFO - 2015-11-20 19:09:00,457 DEBUG : BROWSER_OUTPUT: __end_cc_report 19:09:00 INFO - 2015-11-20 19:09:00,457 DEBUG : BROWSER_OUTPUT: __startTimestamp1448075340454__endTimestamp 19:09:00 INFO - 2015-11-20 19:09:00,457 DEBUG : BROWSER_OUTPUT: 19:09:00 INFO - 2015-11-20 19:09:00,461 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 19:09:00 INFO - 2015-11-20 19:09:00,461 DEBUG : BROWSER_OUTPUT: Number of tests: 14 19:09:00 INFO - 2015-11-20 19:09:00,461 DEBUG : BROWSER_OUTPUT: 19:09:00 INFO - 2015-11-20 19:09:00,461 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:108.00 Median:110.00 stddev:3.06 (2.8%) stddev-sans-first:3.22 19:09:00 INFO - 2015-11-20 19:09:00,461 DEBUG : BROWSER_OUTPUT: Values: 109.0 110.0 103.0 110.0 110.0 110.0 102.0 110.0 109.0 107.0 19:09:00 INFO - 2015-11-20 19:09:00,461 DEBUG : BROWSER_OUTPUT: 19:09:00 INFO - 2015-11-20 19:09:00,462 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:144.70 Median:154.00 stddev:16.19 (10.5%) stddev-sans-first:16.74 19:09:00 INFO - 2015-11-20 19:09:00,462 DEBUG : BROWSER_OUTPUT: Values: 155.0 124.0 149.0 166.0 130.0 153.0 155.0 126.0 162.0 127.0 19:09:00 INFO - 2015-11-20 19:09:00,462 DEBUG : BROWSER_OUTPUT: 19:09:00 INFO - 2015-11-20 19:09:00,462 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:160.80 Median:161.00 stddev:0.79 (0.5%) stddev-sans-first:0.83 19:09:00 INFO - 2015-11-20 19:09:00,462 DEBUG : BROWSER_OUTPUT: Values: 161.0 161.0 160.0 161.0 161.0 160.0 160.0 162.0 162.0 160.0 19:09:00 INFO - 2015-11-20 19:09:00,462 DEBUG : BROWSER_OUTPUT: 19:09:00 INFO - 2015-11-20 19:09:00,463 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:81.50 Median:73.00 stddev:13.68 (18.7%) stddev-sans-first:14.07 19:09:00 INFO - 2015-11-20 19:09:00,463 DEBUG : BROWSER_OUTPUT: Values: 72.0 73.0 80.0 90.0 72.0 73.0 73.0 108.0 102.0 72.0 19:09:00 INFO - 2015-11-20 19:09:00,463 DEBUG : BROWSER_OUTPUT: 19:09:00 INFO - 2015-11-20 19:09:00,463 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:105.40 Median:90.00 stddev:24.37 (27.1%) stddev-sans-first:25.20 19:09:00 INFO - 2015-11-20 19:09:00,463 DEBUG : BROWSER_OUTPUT: Values: 90.0 91.0 148.0 90.0 90.0 91.0 133.0 91.0 90.0 140.0 19:09:00 INFO - 2015-11-20 19:09:00,463 DEBUG : BROWSER_OUTPUT: 19:09:00 INFO - 2015-11-20 19:09:00,464 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:109.40 Median:109.50 stddev:0.52 (0.5%) stddev-sans-first:0.50 19:09:00 INFO - 2015-11-20 19:09:00,464 DEBUG : BROWSER_OUTPUT: Values: 110.0 109.0 110.0 110.0 109.0 110.0 109.0 109.0 109.0 109.0 19:09:00 INFO - 2015-11-20 19:09:00,464 DEBUG : BROWSER_OUTPUT: 19:09:00 INFO - 2015-11-20 19:09:00,464 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:145.90 Median:146.00 stddev:0.99 (0.7%) stddev-sans-first:1.05 19:09:00 INFO - 2015-11-20 19:09:00,464 DEBUG : BROWSER_OUTPUT: Values: 146.0 145.0 146.0 147.0 146.0 145.0 146.0 145.0 148.0 145.0 19:09:00 INFO - 2015-11-20 19:09:00,464 DEBUG : BROWSER_OUTPUT: 19:09:00 INFO - 2015-11-20 19:09:00,465 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:95.50 Median:96.00 stddev:0.53 (0.5%) stddev-sans-first:0.53 19:09:00 INFO - 2015-11-20 19:09:00,465 DEBUG : BROWSER_OUTPUT: Values: 95.0 95.0 95.0 95.0 96.0 96.0 96.0 96.0 95.0 96.0 19:09:00 INFO - 2015-11-20 19:09:00,465 DEBUG : BROWSER_OUTPUT: 19:09:00 INFO - 2015-11-20 19:09:00,465 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:60.60 Median:60.00 stddev:3.44 (5.7%) stddev-sans-first:3.60 19:09:00 INFO - 2015-11-20 19:09:00,465 DEBUG : BROWSER_OUTPUT: Values: 59.0 60.0 59.0 60.0 61.0 59.0 59.0 68.0 56.0 65.0 19:09:00 INFO - 2015-11-20 19:09:00,465 DEBUG : BROWSER_OUTPUT: 19:09:00 INFO - 2015-11-20 19:09:00,465 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:69.70 Median:70.00 stddev:0.48 (0.7%) stddev-sans-first:0.44 19:09:00 INFO - 2015-11-20 19:09:00,465 DEBUG : BROWSER_OUTPUT: Values: 69.0 70.0 69.0 70.0 70.0 70.0 70.0 70.0 70.0 69.0 19:09:00 INFO - 2015-11-20 19:09:00,466 DEBUG : BROWSER_OUTPUT: 19:09:00 INFO - 2015-11-20 19:09:00,466 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:84.40 Median:84.00 stddev:2.76 (3.3%) stddev-sans-first:2.88 19:09:00 INFO - 2015-11-20 19:09:00,466 DEBUG : BROWSER_OUTPUT: Values: 83.0 83.0 83.0 84.0 85.0 83.0 84.0 92.0 84.0 83.0 19:09:00 INFO - 2015-11-20 19:09:00,466 DEBUG : BROWSER_OUTPUT: 19:09:00 INFO - 2015-11-20 19:09:00,466 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:121.00 Median:121.00 stddev:5.44 (4.5%) stddev-sans-first:5.75 19:09:00 INFO - 2015-11-20 19:09:00,466 DEBUG : BROWSER_OUTPUT: Values: 120.0 112.0 119.0 122.0 125.0 117.0 120.0 125.0 118.0 132.0 19:09:00 INFO - 2015-11-20 19:09:00,466 DEBUG : BROWSER_OUTPUT: 19:09:00 INFO - 2015-11-20 19:09:00,466 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:146.60 Median:148.00 stddev:8.22 (5.6%) stddev-sans-first:8.11 19:09:00 INFO - 2015-11-20 19:09:00,466 DEBUG : BROWSER_OUTPUT: Values: 138.0 139.0 149.0 148.0 165.0 140.0 153.0 148.0 146.0 140.0 19:09:00 INFO - 2015-11-20 19:09:00,466 DEBUG : BROWSER_OUTPUT: 19:09:00 INFO - 2015-11-20 19:09:00,466 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.80 Median:66.50 stddev:2.04 (3.1%) stddev-sans-first:2.06 19:09:00 INFO - 2015-11-20 19:09:00,466 DEBUG : BROWSER_OUTPUT: Values: 65.0 72.0 66.0 66.0 67.0 65.0 68.0 67.0 66.0 66.0 19:09:00 INFO - 2015-11-20 19:09:00,467 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 19:09:00 INFO - 2015-11-20 19:09:00,467 DEBUG : BROWSER_OUTPUT: 19:09:01 INFO - 2015-11-20 19:09:01,330 INFO : Browser exited with error code: 0 19:09:01 INFO - 2015-11-20 19:09:01,381 INFO : Completed test kraken (00:00:58) 19:09:01 INFO - 2015-11-20 19:09:01,381 INFO : Starting test v8_7 19:09:01 INFO - 2015-11-20 19:09:01,381 DEBUG : operating with platform_type : linux_ 19:09:01 INFO - 2015-11-20 19:09:01,381 INFO : Initialising browser for v8_7 test... 19:09:01 INFO - 2015-11-20 19:09:01,387 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpgcWWtl/profile http://localhost:53774/getInfo.html 19:09:05 INFO - 2015-11-20 19:09:05,324 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 19:09:05 INFO - 2015-11-20 19:09:05,324 DEBUG : BROWSER_OUTPUT: colorDepth:24 19:09:05 INFO - 2015-11-20 19:09:05,324 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 19:09:05 INFO - 2015-11-20 19:09:05,324 DEBUG : BROWSER_OUTPUT: __metrics 19:09:05 INFO - 2015-11-20 19:09:05,420 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:09:06 INFO - 2015-11-20 19:09:06,707 INFO : Browser initialized. 19:09:06 INFO - 2015-11-20 19:09:06,707 INFO : Running cycle 1/1 for v8_7 test... 19:09:06 INFO - 2015-11-20 19:09:06,707 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpgcWWtl/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 19:09:18 INFO - 2015-11-20 19:09:18,480 DEBUG : BROWSER_OUTPUT: RSS: Main: 141803520 19:09:18 INFO - 2015-11-20 19:09:18,480 DEBUG : BROWSER_OUTPUT: 19:09:39 INFO - 2015-11-20 19:09:39,820 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53774/tests/v8_7/run.html (next: http://localhost:53774/tests/v8_7/run.html) 19:09:40 INFO - 2015-11-20 19:09:40,070 DEBUG : BROWSER_OUTPUT: RSS: Main: 534802432 19:09:40 INFO - 2015-11-20 19:09:40,071 DEBUG : BROWSER_OUTPUT: 19:09:40 INFO - 2015-11-20 19:09:40,072 DEBUG : BROWSER_OUTPUT: __start_tp_report 19:09:40 INFO - 2015-11-20 19:09:40,072 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 19:09:40 INFO - 2015-11-20 19:09:40,072 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 19:09:40 INFO - 2015-11-20 19:09:40,072 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 19:09:40 INFO - 2015-11-20 19:09:40,072 DEBUG : BROWSER_OUTPUT: |0;Richards;162.41676140977748 19:09:40 INFO - 2015-11-20 19:09:40,073 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;194.06171162429652 19:09:40 INFO - 2015-11-20 19:09:40,073 DEBUG : BROWSER_OUTPUT: |2;Encrypt;285.8776443682104 19:09:40 INFO - 2015-11-20 19:09:40,073 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5025.125628140703 19:09:40 INFO - 2015-11-20 19:09:40,073 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1111.111111111111 19:09:40 INFO - 2015-11-20 19:09:40,073 DEBUG : BROWSER_OUTPUT: |5;Earley;780.64012490242 19:09:40 INFO - 2015-11-20 19:09:40,074 DEBUG : BROWSER_OUTPUT: |6;Boyer;12084.33734939759 19:09:40 INFO - 2015-11-20 19:09:40,074 DEBUG : BROWSER_OUTPUT: |7;RegExp;26552.63157894737 19:09:40 INFO - 2015-11-20 19:09:40,074 DEBUG : BROWSER_OUTPUT: |8;Splay;597.3715651135007 19:09:40 INFO - 2015-11-20 19:09:40,074 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4830.917874396136 19:09:40 INFO - 2015-11-20 19:09:40,074 DEBUG : BROWSER_OUTPUT: __end_tp_report 19:09:40 INFO - 2015-11-20 19:09:40,075 DEBUG : BROWSER_OUTPUT: __startTimestamp1448075380071__endTimestamp 19:09:40 INFO - 2015-11-20 19:09:40,075 DEBUG : BROWSER_OUTPUT: 19:09:40 INFO - 2015-11-20 19:09:40,075 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 19:09:40 INFO - 2015-11-20 19:09:40,075 DEBUG : BROWSER_OUTPUT: Number of tests: 10 19:09:40 INFO - 2015-11-20 19:09:40,076 DEBUG : BROWSER_OUTPUT: 19:09:40 INFO - 2015-11-20 19:09:40,076 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:162.42 Median:162.42 stddev:0.00 (0.0%) 19:09:40 INFO - 2015-11-20 19:09:40,076 DEBUG : BROWSER_OUTPUT: Values: 162.4 19:09:40 INFO - 2015-11-20 19:09:40,076 DEBUG : BROWSER_OUTPUT: 19:09:40 INFO - 2015-11-20 19:09:40,077 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:194.06 Median:194.06 stddev:0.00 (0.0%) 19:09:40 INFO - 2015-11-20 19:09:40,077 DEBUG : BROWSER_OUTPUT: Values: 194.1 19:09:40 INFO - 2015-11-20 19:09:40,077 DEBUG : BROWSER_OUTPUT: 19:09:40 INFO - 2015-11-20 19:09:40,077 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:285.88 Median:285.88 stddev:0.00 (0.0%) 19:09:40 INFO - 2015-11-20 19:09:40,077 DEBUG : BROWSER_OUTPUT: Values: 285.9 19:09:40 INFO - 2015-11-20 19:09:40,077 DEBUG : BROWSER_OUTPUT: 19:09:40 INFO - 2015-11-20 19:09:40,078 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5025.13 Median:5025.13 stddev:0.00 (0.0%) 19:09:40 INFO - 2015-11-20 19:09:40,078 DEBUG : BROWSER_OUTPUT: Values: 5025.1 19:09:40 INFO - 2015-11-20 19:09:40,078 DEBUG : BROWSER_OUTPUT: 19:09:40 INFO - 2015-11-20 19:09:40,078 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1111.11 Median:1111.11 stddev:0.00 (0.0%) 19:09:40 INFO - 2015-11-20 19:09:40,078 DEBUG : BROWSER_OUTPUT: Values: 1111.1 19:09:40 INFO - 2015-11-20 19:09:40,078 DEBUG : BROWSER_OUTPUT: 19:09:40 INFO - 2015-11-20 19:09:40,078 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:780.64 Median:780.64 stddev:0.00 (0.0%) 19:09:40 INFO - 2015-11-20 19:09:40,079 DEBUG : BROWSER_OUTPUT: Values: 780.6 19:09:40 INFO - 2015-11-20 19:09:40,079 DEBUG : BROWSER_OUTPUT: 19:09:40 INFO - 2015-11-20 19:09:40,080 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:12084.34 Median:12084.34 stddev:0.00 (0.0%) 19:09:40 INFO - 2015-11-20 19:09:40,080 DEBUG : BROWSER_OUTPUT: Values: 12084.3 19:09:40 INFO - 2015-11-20 19:09:40,080 DEBUG : BROWSER_OUTPUT: 19:09:40 INFO - 2015-11-20 19:09:40,080 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:26552.63 Median:26552.63 stddev:0.00 (0.0%) 19:09:40 INFO - 2015-11-20 19:09:40,080 DEBUG : BROWSER_OUTPUT: Values: 26552.6 19:09:40 INFO - 2015-11-20 19:09:40,080 DEBUG : BROWSER_OUTPUT: 19:09:40 INFO - 2015-11-20 19:09:40,080 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:597.37 Median:597.37 stddev:0.00 (0.0%) 19:09:40 INFO - 2015-11-20 19:09:40,080 DEBUG : BROWSER_OUTPUT: Values: 597.4 19:09:40 INFO - 2015-11-20 19:09:40,080 DEBUG : BROWSER_OUTPUT: 19:09:40 INFO - 2015-11-20 19:09:40,080 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4830.92 Median:4830.92 stddev:0.00 (0.0%) 19:09:40 INFO - 2015-11-20 19:09:40,080 DEBUG : BROWSER_OUTPUT: Values: 4830.9 19:09:40 INFO - 2015-11-20 19:09:40,080 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 19:09:40 INFO - 2015-11-20 19:09:40,080 DEBUG : BROWSER_OUTPUT: 19:09:40 INFO - 2015-11-20 19:09:40,878 INFO : Browser exited with error code: 0 19:09:40 INFO - 2015-11-20 19:09:40,894 INFO : Completed test v8_7 (00:00:39) 19:09:41 INFO - 2015-11-20 19:09:41,128 INFO : Completed test suite (00:20:12) 19:09:41 INFO - 2015-11-20 19:09:41,129 DEBUG : Working with test: dromaeo_css 19:09:41 INFO - 2015-11-20 19:09:41,129 DEBUG : Generating results file: dromaeo_css 19:09:41 INFO - 2015-11-20 19:09:41,130 DEBUG : Working with test: kraken 19:09:41 INFO - 2015-11-20 19:09:41,130 DEBUG : Generating results file: kraken 19:09:41 INFO - 2015-11-20 19:09:41,130 INFO : javascript benchmark 19:09:41 INFO - 2015-11-20 19:09:41,130 DEBUG : Working with test: v8_7 19:09:41 INFO - 2015-11-20 19:09:41,131 DEBUG : Generating results file: v8_7 19:09:41 INFO - 2015-11-20 19:09:41,131 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 19:09:41 INFO - 2015-11-20 19:09:41,182 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,1,35]] 19:09:41 INFO - 2015-11-20 19:09:41,182 DEBUG : process_Request line: dromaeo_css 6947.21 graph.html#tests=[[72,1,35]] 19:09:41 INFO - 2015-11-20 19:09:41,182 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 19:09:41 INFO - 2015-11-20 19:09:41,213 DEBUG : process_Request line: kraken 1500.30 graph.html#tests=[[232,1,35]] 19:09:41 INFO - 2015-11-20 19:09:41,213 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 19:09:41 INFO - 2015-11-20 19:09:41,242 DEBUG : process_Request line: v8_7 21056.68 graph.html#tests=[[230,1,35]] 19:09:41 INFO - 2015-11-20 19:09:41,243 INFO : javascript benchmark 19:09:41 INFO - 2015-11-20 19:09:41,247 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3113.828739419332, 3225.806451612902, 3268.1339445047065, 3277.098797830598, 3299.208190034391, 5242.135047717122, 5332.440093790155, 5371.301730774999, 5419.0, 5513.062779327519, 5323.866903327419, 5341.1187154119625, 5351.25082488451, 5357.08929481988, 5416.91874621881, 4896.87757806055, 4974.278729584208, 5002.574781143607, 5022.522860328263, 5066.1640829263315, 4733.8343157989475, 4973.204287314031, 4983.377077865267, 5024.572911302544, 5059.241113832936, 4848.587870031034, 4874.3419638348905, 4918.508149185089, 4947.727874966876, 4955.182394904837, 4929.65492415531, 4931.26031095335, 4940.456549779521, 4948.233023881268, 4977.42759582649, 4818.325434439182, 4920.926186107211, 4938.209886418156, 4944.554990050912, 4966.5778408835295, 5175.456577059392, 5245.527902488756, 5341.278927344798, 5353.759080841332, 5368.0, 5902.8819423611285, 5909.970450147722, 5914.0, 5919.792807251725, 5920.230370051909, 5741.138829175616, 5844.152597873284, 5944.256967879015, 5949.494292985101, 5951.761929522814, 5452.945470545284, 5528.75120619565, 5573.526250268773, 5591.4688104629995, 5593.077142271521, 5898.557608179403, 5912.17229587858, 5922.555808314393, 5935.465808077293, 5962.552808539377, 5624.0439125348785, 5795.33353664334, 5809.477147056785, 5845.883082338414, 5852.268466441695, 5653.830385088454, 5710.600257981984, 5720.599558030981, 5795.681237531892, 5868.295804503487, 5782.0, 5833.67914764692, 5837.416258374129, 5842.152887831241, 5844.970775146097, 5584.832455026356, 5811.476967072899, 5822.155787410802, 5826.70866456684, 5834.620749651259, 4456.9331460028125, 4458.464984201852, 4471.709338892962, 4530.252508336088, 4556.589906908328, 3993.960060399359, 4006.318925782624, 4024.396340548941, 4027.073773032219, 4066.4103704962613, 5590.496855283044, 5591.552675785927, 5600.551955843523, 5601.131824567198, 5626.634268772598, 5547.278853749068, 5690.317161940511, 5723.77104915807, 5878.470937615635, 5894.145348924382, 5587.860303492445, 5598.720063996784, 5601.551875849922, 5602.0, 5620.044592419216, 4955.851324460272, 4956.033573453215, 4964.081644895706, 4967.155583550805, 5013.974930125326, 5794.130880367894, 5801.593888427769, 5810.1865738796605, 5993.910091348721, 6099.908501372394, 5815.563832712648, 5845.590808643354, 5888.94111058901, 5891.882162356815, 5895.852603684771, 6010.789622363196, 6017.3681763414215, 6025.578209525466, 6036.336003039574, 6038.69806509664, 5641.464060914206, 5646.2942132233475, 5700.458456446631, 5732.34078081026, 5836.066229403275, 5823.505002074871, 5836.766529338779, 5838.299404071538, 5840.123981402823, 5856.472917437451, 5773.0, 5783.045797443375, 5784.363719990713, 5800.1299805029585, 5806.622569532967, 5531.8893622128135, 5598.664080155204, 5650.519705825051, 5663.490285874291, 5721.914171287351, 5563.471470210324, 5569.443055694398, 5575.4424557543925, 5577.553795696415, 5578.163275508544, 5690.37405885344, 5712.228849105484, 5737.168110624019, 5746.569007324384, 5758.193852860519, 5417.349918009864, 5506.0, 5517.613767036269, 5539.58453116026, 5676.375598684224], "unit": "ms", "name": "dojo.html", "value": 5368.182144980271}, {"lowerIsBetter": false, "replicates": [563.1412096552757, 613.938606139386, 616.7656290609568, 618.3723520626568, 619.8729260501597, 32095.839520802394, 39822.0, 40218.59781402185, 40224.19551608966, 40243.59756402442, 42219.577804221946, 42614.786926065324, 42650.786746066304, 42768.57231427685, 42798.0, 7679.6160191990175, 7810.0, 8700.65197392105, 8858.645654173826, 8921.598528066253, 7635.580043097628, 7714.074311082678, 10507.21195910306, 10734.463276836126, 10738.677839664822, 10433.582656693723, 10555.155587552978, 10560.207984401162, 10563.41901195434, 10563.683089507327, 7808.0, 10367.688969330895, 10449.47752612374, 10459.215558833042, 10466.738331541696, 7656.0, 10079.496025198783, 10357.171426285879, 10364.79270414595, 10378.11785998191, 36162.276754464765, 36573.0, 36624.26751464956, 36645.450318245246, 36705.08237294089, 3280.5899262592175, 3319.3029463812627, 3327.1349449143395, 3420.3330350581646, 3436.742244331685, 29725.55411668827, 30352.0, 30476.514057589346, 30906.53640195399, 31748.20629484258, 3252.8339083292394, 3271.574695289621, 3289.0954987378423, 3411.385950528904, 3414.8634054637787, 276944.0, 277477.0, 277671.0, 278224.0, 278641.0, 54280.0, 55166.72416637971, 55491.44508554863, 55721.442785572435, 56270.1864906753, 53627.0, 54206.45793542093, 54370.45629543654, 54607.0, 54683.453165467836, 14812.111273323635, 14998.925005374904, 15011.624709382353, 15028.474003409829, 15033.323500442506, 11458.0, 11473.885261147281, 11519.366434846164, 11535.36555489456, 11543.36511491876, 18048.639027219644, 18621.0, 18804.90597547031, 18882.81117188838, 18937.0, 7647.19399734237, 7739.651715672809, 7931.325837303893, 7981.48120372174, 8015.83968320642, 935.5322338830584, 978.7602037500716, 984.4683870709737, 1002.2683441088046, 1088.689723428819, 24997.250082497554, 25022.37444063913, 26916.327091822863, 27276.31809204786, 27451.0, 1028.4497793680346, 1065.8774240962234, 1066.4987455895716, 1074.9516271767789, 1159.2349049627373, 14302.712755852022, 14349.282535873164, 14355.56933292003, 14484.203368814817, 14520.782188267185, 302189.0, 306530.0, 307070.0, 307343.0, 307474.0, 53244.46755532473, 53477.1978420324, 53568.0, 53598.46401535935, 53610.73194634002, 1323.993380033113, 1326.7943468762357, 1342.6911810283493, 1343.8588948160498, 1345.0987838148465, 27046.72953270442, 27513.44973100567, 27791.44417111606, 27951.0, 28084.0, 42492.57507424886, 45374.54625453703, 45701.54298456973, 45773.54226457693, 45807.0, 215956.0, 217040.0, 297838.0, 308035.0, 308058.0, 29392.412151756416, 29554.0, 29639.0, 29716.0, 29730.405391892473, 40581.39127913143, 42848.35727464028, 43311.0, 43897.34153987757, 44033.11933761243, 37297.0, 37377.81311093427, 37509.4373584391, 38645.61354386533, 38705.806470967465, 35547.11132221715, 35609.28781424409, 36466.27067458689, 36659.0, 36843.07892302714, 33617.495737564444, 33639.83180084182, 33646.15884602807, 35755.46366804448, 36090.63909360873, 29204.561931570617, 30286.54570181493, 30545.0, 30593.0, 30594.694053059186, 24824.533796913824, 25013.374665633506, 25114.121005765443, 25309.367265818502, 25501.0], "unit": "ms", "name": "ext.html", "value": 18324.697490851035}, {"lowerIsBetter": false, "replicates": [355.91102224443887, 359.9100224943764, 362.87843572403244, 363.4856677800912, 364.8558819266388, 14143.434262629507, 14240.216788076652, 16553.83446165538, 16968.49094527163, 17611.207495662693, 13319.933400332984, 14156.929215353935, 16028.278727457264, 16717.414890478834, 16768.41310554131, 5401.78392864285, 5570.693611851347, 5571.774209673866, 5575.303087114111, 5580.079286917674, 3978.701597380208, 4020.5376381716037, 5538.418466061066, 5580.441955804407, 5889.322727886283, 5954.583179177459, 5979.880402391949, 5984.251968503937, 5988.490978266853, 5990.6106103103375, 4993.051320249141, 5140.203268493389, 5154.587632989352, 5170.276161337416, 5962.34414214436, 4960.131976904027, 4961.677490963076, 4984.102861484931, 5056.721880296583, 5244.711540865251, 19573.412797616093, 19611.313604023933, 19962.70055949162, 20014.09936552844, 20032.899835500873, 2013.8993050347572, 2088.4778805298674, 2111.514351699118, 2244.0, 2357.0807385119647, 9189.724308270763, 9199.494027828467, 9264.768380790467, 12089.879101208964, 12928.246940030547, 1771.8936863788085, 1789.168036862852, 1803.1705415508882, 1808.2405389736343, 1891.5649400637792, 56071.719641401534, 57597.0, 62092.0, 64125.35874641241, 65405.672971634835, 9092.818143637223, 9532.618695252251, 10012.64955726546, 10067.949660251652, 10163.44101074448, 13330.800037999437, 13359.265240411676, 13379.0, 13381.264030478416, 13389.330533473481, 7474.551526908403, 7506.662200201004, 7507.887381689279, 7518.173000969889, 7568.394528437711, 7170.677319520634, 7210.206877243499, 7226.349628533457, 7255.927440725631, 7263.782086537412, 4241.87274381769, 4293.0769884474985, 4413.16149931512, 4417.469903611587, 4455.2648812946145, 1721.3028723367056, 1743.651269746056, 1757.8417942385247, 1770.2299499717665, 1793.390247315919, 922.2529750901791, 939.2767568971854, 988.9406635601887, 989.1839232633107, 994.5176589354157, 16110.919445402933, 16773.83226167747, 17157.914210429117, 17406.91296543509, 17700.9114954427, 892.2638822971074, 931.4364809290417, 937.5734041011324, 949.1457688080644, 997.7405874472689, 7736.458447908705, 9760.560774765152, 9769.706908792748, 9780.168685661798, 9792.21662267017, 520723.0, 522915.0, 524312.0, 549740.0, 558576.0, 76175.61912190403, 79710.0, 80145.59927200443, 80187.0, 80742.0, 1101.7465982823996, 1102.3606308341143, 1110.6168371911679, 1114.6934592986831, 1116.3413585984147, 15093.622659433162, 15171.468998584996, 15223.0, 15227.238638068275, 15651.139187344805, 35230.0, 35569.46645800264, 35633.1091722709, 37098.44352334663, 39503.80248098741, 47453.288200676325, 47557.0, 48184.27723584079, 50565.74717126391, 52614.210786837466, 14559.85440145585, 14865.182414966848, 14936.477223297132, 15107.32017059257, 15133.54599362021, 10639.361638301418, 10893.400862952614, 10903.091958907318, 10967.341959482457, 11015.449227538431, 8572.314214862672, 8607.65569377218, 9866.654667086617, 9926.354786938826, 10022.098011179029, 9623.278254131108, 9926.602935882484, 9999.850002250118, 10047.949760251153, 10365.274430789772, 8338.833223335621, 9471.47906865129, 9925.1067403934, 9967.302288839712, 10145.442000690033, 14768.556943291718, 14896.702065958403, 15061.47284845069, 15084.170370629721, 15131.092134471966, 14326.856731432968, 14338.0, 14998.175100369584, 15475.613109672347, 15820.28808703588], "unit": "ms", "name": "jquery.html", "value": 8698.881151331272}, {"lowerIsBetter": false, "replicates": [1009.5053423822329, 1722.6382459683464, 1777.5467255849765, 1786.9106544672763, 1804.891706497611, 6646.501512386566, 7299.4890357674985, 7423.700852350844, 7431.739889103883, 7434.442416818733, 7323.816904577388, 7482.700691972328, 7512.286332798389, 7514.0607424071995, 7520.0, 1951.7267582538457, 1975.2790231565448, 1975.3777560068531, 2250.223672832874, 2277.464795772992, 2250.1224522436264, 2283.6917016202765, 2284.794368506834, 2285.919992800252, 2288.107638021173, 2185.1259496201487, 2210.0386331945656, 2264.728232612089, 2280.5894938910988, 2285.6571514272828, 1921.634889371022, 1952.1020330647848, 1953.7557805274341, 1954.257382194771, 2242.3385101395047, 1968.4094771568473, 2202.3392982105465, 2234.4190510467233, 2234.971912920059, 2236.1837929155904, 7521.811954701122, 7554.206808285161, 7615.428842836754, 7621.466497345188, 7632.732854350126, 4532.750698711569, 4541.931871021938, 4588.541145885418, 4606.470255920579, 4613.907721845578, 3003.9399212015855, 3005.1285127313054, 3099.209701526119, 3103.7827352085365, 3104.9689503105133, 962.3119469579215, 965.956766691971, 976.5947131940236, 988.7478692933256, 1011.5043628621922, 10341.586336546528, 10355.89644103557, 10412.0, 10420.895791042145, 10423.114035307008, 4134.462519872397, 4181.519125300569, 4196.265653510684, 4238.87283381499, 4247.51153617338, 8941.59762810675, 8951.0, 8952.104789521127, 8952.8657070144, 8961.462312261285, 4661.324108004321, 4679.461861885927, 4694.577488026094, 4695.060987802453, 4696.718196908197, 4216.47294088239, 4224.91550169001, 4235.025944032828, 4236.703430759817, 4241.745495270232, 3572.8749493767596, 3602.4776407420777, 3605.3149901518627, 3616.403293456603, 3640.7997560134445, 1164.8660404053473, 1169.8128299472044, 1170.0931777872047, 1172.4489489939715, 1174.0372894226653, 1263.91784534005, 1272.1985149356033, 1302.7785276503016, 1340.825692659948, 1341.2824139085542, 7120.572765634079, 7140.107486564179, 7185.173705023884, 7186.532875363085, 7214.350708436266, 455.5490064835855, 456.6940150099441, 456.8789270843229, 465.37407187332985, 477.5678011399689, 5165.9483405165465, 5296.04671159195, 5452.018636645442, 5502.8349149525575, 5602.299712535933, 8852.513111778913, 9090.181883630505, 9135.725928222164, 9143.03998080192, 9147.54262286883, 8859.64561417549, 8930.19628233462, 9252.352335336596, 9262.16640502358, 9275.25797936177, 7072.92927070733, 7144.714211431588, 7157.176924653628, 7203.351698347174, 7205.675744591506, 7021.1574611047, 7192.784216473514, 7200.0, 7203.8919416207755, 7205.819854503679, 7839.098503671923, 8090.595470226347, 8128.105908349959, 8139.79650508742, 8262.628181731716, 8313.33493320545, 8373.539455330016, 8395.202455766692, 8415.95792021036, 8503.362247831314, 6872.41584465306, 6933.5493192942295, 6943.201531823703, 6944.652767361511, 6953.443724501926, 7194.388476979515, 7277.636118194175, 7286.744963926237, 7322.0115284435915, 7349.412047036331, 6984.4761642878, 7049.682764275517, 7125.964370178116, 7138.321859423347, 7156.3917067047805, 6849.828754280983, 6861.142357205349, 6901.0, 7034.683439245348, 7036.36672699439, 6933.687984040629, 6967.442604591722, 6984.895226571504, 6991.161060672752, 7010.053642758367, 6203.286622038523, 6277.435030847246, 6319.3364696706185, 6336.366363363627, 6348.016057511093, 6339.112524246517, 6359.936400635935, 6376.39424254695, 6378.33027532121, 6386.87226255463], "unit": "ms", "name": "mootools.html", "value": 4303.029718366978}, {"lowerIsBetter": false, "replicates": [314.39792796794137, 315.9682451913582, 317.11999202213855, 321.0689001894504, 324.9707526322631, 5877.9118313225335, 5983.970080149598, 6021.157038014681, 6063.242094738158, 6074.726637301321, 5827.796027139051, 5917.585768996172, 6001.279846418436, 6014.699265036742, 6016.2479690038745, 4369.0, 4576.244919588272, 4606.286025666011, 4610.700304480215, 4615.030843522864, 4482.282834746425, 4504.481984571784, 4504.932426013613, 4505.414296141497, 4551.340055691922, 4549.567791059844, 4576.8626941191815, 4584.885377865563, 4595.379623750801, 4600.861974140765, 4571.771411429432, 4576.107659006479, 4578.336141259532, 4582.473015603215, 4585.449746030497, 4010.5588385277597, 4011.0774521860135, 4012.0, 4016.9957510622344, 4026.375911733686, 5550.666959982374, 5659.377468478464, 5692.57305702074, 5724.055530837407, 5727.3699893011735, 5286.15421532553, 5314.309139811839, 5323.680579165262, 5333.973330133364, 5337.786488540453, 6365.809025729235, 6381.138546296237, 6381.8085457436355, 6381.968090159519, 6384.3296453872135, 4320.546342634009, 4324.891877703051, 4439.489458712257, 4444.688871778977, 4444.711093778927, 6624.6025238485845, 6626.436752876011, 6635.635040072794, 6635.9336406636285, 6636.435902948255, 4516.36770852081, 4540.682152249311, 4543.477500087466, 4544.818207271672, 4545.2954792007295, 4597.287420449836, 4597.609203217697, 4599.2871104978785, 4600.033992861537, 4605.930911036337, 5091.9236211456855, 5234.869128271824, 5241.895162096736, 5243.842684719464, 5317.548008419328, 6456.7740129095255, 6460.386263305072, 6463.192100987377, 6466.159399278064, 6474.9963755617955, 1563.4059057558054, 1578.7237233484095, 1579.7946266985218, 1581.6283173454228, 1582.0586750883435, 1022.5449674894601, 1029.53156313877, 1037.9740506487246, 1041.9479026048666, 1054.2198772908146, 6131.50947924165, 6174.289956654952, 6184.288806787277, 6194.473469755121, 6199.0, 6414.903776443357, 6590.472762179014, 6613.470922326299, 6616.14747870597, 6618.371254730793, 6117.480014198754, 6171.290301615282, 6235.625862448268, 6283.748650053946, 6291.653959032205, 3556.8577256909953, 3562.6437356264164, 3563.2339047104997, 3586.964130358663, 3588.4617307404096, 6683.832904177337, 6774.42417394527, 6873.862522749517, 6877.793666190022, 6881.483888708267, 6833.726650934006, 6864.931350686529, 6873.0, 6874.621895795679, 6876.106106206261, 6768.390844823989, 6774.491913106537, 6775.390214880685, 6780.0, 6784.660766961632, 6547.051630773762, 6646.966765166143, 6685.799426017227, 6689.397954184147, 6699.497537684596, 6598.1422415085735, 6606.8348291293105, 6625.039369291329, 6626.966865165643, 6636.800895973129, 6876.793696189123, 6878.55289406187, 6879.828004299932, 6888.242293347627, 6892.896606550806, 4371.453568303962, 4486.64106871443, 4487.237169681227, 4492.0, 4496.842610508616, 6442.291347951816, 6446.774362897276, 6451.838704032437, 6453.1610890583925, 6456.580322279036, 6301.779437719658, 6322.178116844781, 6337.302896681269, 6338.841528961812, 6340.0, 6180.412860778219, 6307.117003619405, 6331.90502142459, 6340.651264180515, 6348.746050157942, 6167.660778657038, 6172.907406388818, 6176.722047507963, 6177.949748542668, 6180.289266734203, 6296.811095667137, 6342.334054924351, 6352.618842869442, 6360.618362898241, 6365.745370185141, 6018.337982821974, 6083.7870674526175, 6122.510199183966, 6152.384761523812, 6219.751209951733], "unit": "ms", "name": "prototype.html", "value": 4787.877175134976}, {"lowerIsBetter": false, "replicates": [766.5017738469994, 832.9042160151581, 841.1672444280165, 862.9956850215748, 864.2740098317412, 13901.0, 14069.0, 14157.575272741808, 14175.149491030545, 14185.78721319181, 13185.802212966813, 13294.534691285808, 13304.135231209988, 13305.933470332659, 13330.200187988727, 683.111954459201, 688.3770187979886, 821.1583127294541, 836.1471299274751, 836.9874451883196, 835.419383528448, 844.5903736687701, 845.3490812074699, 847.4533925618003, 850.0691742541937, 721.8195451137216, 889.728632767009, 894.4007514964957, 894.4275663575316, 895.5566994337812, 723.4718655381574, 870.268974061788, 884.460479107747, 885.0353115104567, 885.9955700221523, 653.3042309939899, 653.5490511547017, 654.1496055128362, 654.3554598720257, 654.9410553050249, 13355.599332020054, 13466.25935573543, 13552.119112257671, 13572.45710171592, 13579.0, 12554.874451255462, 12876.163049401759, 13122.14706044104, 13175.814176724141, 13477.460901563925, 10318.535665894977, 10457.633982810565, 10522.526486308134, 10538.894611053867, 10563.524641391155, 3608.783472991629, 3610.855565777366, 3618.0, 3677.4667673187237, 3783.754055986352, 46265.5373446268, 46302.305465418045, 46413.30380044302, 46418.0, 46693.29960050602, 9701.272404569545, 9748.366356186825, 9839.80320393588, 9873.901260987443, 10155.441450720133, 18386.540336491427, 18481.353152639862, 18483.16825742845, 18485.63028739418, 18487.0, 7249.238829922782, 7470.402367810562, 7600.695972161162, 7654.96172519145, 7681.155072941972, 4200.199962383304, 4298.075913678574, 4353.869383918487, 4369.781510924505, 4431.313146462304, 3104.891328803526, 3155.8422078895965, 3173.444647186733, 3181.2524056846623, 3181.459151944175, 526.4261954469647, 531.8936212757386, 537.6317222702461, 540.5810496864882, 542.5090293284584, 621.3413781391739, 629.3580547841176, 639.9392057754505, 654.3816093791321, 684.3703792510902, 8802.691905783267, 8819.29445644347, 8893.110688931185, 8902.376833621584, 8979.0, 501.8218532421011, 516.354556803995, 572.7537159021578, 698.6297262450909, 716.8244079709281, 4004.799760011988, 4055.3308704063497, 4223.155368926227, 4353.499347575006, 4448.288273876165, 56917.43082569121, 57739.711301443225, 58015.0, 58104.0, 58184.12723809146, 49247.105405243296, 49567.50432495629, 50039.24941125886, 50507.24239136416, 50881.0, 46046.079078418246, 46096.0, 47266.5273347269, 47695.28457073147, 47975.76012119917, 8978.86531702038, 9051.366404351633, 9248.260139188715, 9290.0, 9434.48110353937, 35551.46672799858, 35641.46537801883, 36225.0, 36410.45384319184, 37042.62957370392, 44395.33406998833, 44687.329690055325, 44809.327860081474, 45559.31661025154, 45927.54072459233, 10836.945815270874, 10942.562297508011, 11521.942390287995, 11532.769344613229, 11668.591599293984, 12593.181443206162, 12633.810492842798, 12798.16811907223, 12888.484460621845, 13348.666283342995, 11379.658610241706, 11731.530738770694, 12000.099992500773, 12095.879041209475, 12359.814602780785, 11048.723781905517, 11280.717982050515, 11561.768764624829, 11654.242474239147, 11990.760184796429, 10498.265121441731, 10866.945665271624, 11044.392558409043, 11217.158713096387, 12102.394880255775, 9302.488363140092, 9434.0, 9439.339246252697, 9976.60093596277, 10084.142847858015, 8897.199252067345, 9064.818703626022, 9469.952650236704, 9471.579263110589, 9939.850902236616], "unit": "ms", "name": "yui.html", "value": 6376.472877671271}], "name": "dromaeo_css", "value": 6947.2151592902}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [109.0, 110.0, 103.0, 110.0, 110.0, 110.0, 102.0, 110.0, 109.0, 107.0], "unit": "ms", "name": "ai-astar", "value": 108.0}, {"lowerIsBetter": true, "replicates": [155.0, 124.0, 149.0, 166.0, 130.0, 153.0, 155.0, 126.0, 162.0, 127.0], "unit": "ms", "name": "audio-beat-detection", "value": 144.7}, {"lowerIsBetter": true, "replicates": [161.0, 161.0, 160.0, 161.0, 161.0, 160.0, 160.0, 162.0, 162.0, 160.0], "unit": "ms", "name": "audio-dft", "value": 160.8}, {"lowerIsBetter": true, "replicates": [72.0, 73.0, 80.0, 90.0, 72.0, 73.0, 73.0, 108.0, 102.0, 72.0], "unit": "ms", "name": "audio-fft", "value": 81.5}, {"lowerIsBetter": true, "replicates": [90.0, 91.0, 148.0, 90.0, 90.0, 91.0, 133.0, 91.0, 90.0, 140.0], "unit": "ms", "name": "audio-oscillator", "value": 105.4}, {"lowerIsBetter": true, "replicates": [110.0, 109.0, 110.0, 110.0, 109.0, 110.0, 109.0, 109.0, 109.0, 109.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 109.4}, {"lowerIsBetter": true, "replicates": [146.0, 145.0, 146.0, 147.0, 146.0, 145.0, 146.0, 145.0, 148.0, 145.0], "unit": "ms", "name": "imaging-darkroom", "value": 145.9}, {"lowerIsBetter": true, "replicates": [95.0, 95.0, 95.0, 95.0, 96.0, 96.0, 96.0, 96.0, 95.0, 96.0], "unit": "ms", "name": "imaging-desaturate", "value": 95.5}, {"lowerIsBetter": true, "replicates": [59.0, 60.0, 59.0, 60.0, 61.0, 59.0, 59.0, 68.0, 56.0, 65.0], "unit": "ms", "name": "json-parse-financial", "value": 60.6}, {"lowerIsBetter": true, "replicates": [69.0, 70.0, 69.0, 70.0, 70.0, 70.0, 70.0, 70.0, 70.0, 69.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 69.7}, {"lowerIsBetter": true, "replicates": [83.0, 83.0, 83.0, 84.0, 85.0, 83.0, 84.0, 92.0, 84.0, 83.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 84.4}, {"lowerIsBetter": true, "replicates": [120.0, 112.0, 119.0, 122.0, 125.0, 117.0, 120.0, 125.0, 118.0, 132.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 121.0}, {"lowerIsBetter": true, "replicates": [138.0, 139.0, 149.0, 148.0, 165.0, 140.0, 153.0, 148.0, 146.0, 140.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 146.6}, {"lowerIsBetter": true, "replicates": [65.0, 72.0, 66.0, 66.0, 67.0, 65.0, 68.0, 67.0, 66.0, 66.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 66.8}], "name": "kraken", "value": 1500.3}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [162.41676140977748], "unit": "score", "name": "Richards", "value": 217.35441400000002}, {"lowerIsBetter": false, "replicates": [194.06171162429652], "unit": "score", "name": "DeltaBlue", "value": 340.70605400000017}, {"lowerIsBetter": false, "replicates": [285.8776443682104], "unit": "score", "name": "Encrypt", "value": 931.1011380000001}, {"lowerIsBetter": false, "replicates": [5025.125628140703], "unit": "score", "name": "Decrypt", "value": 52.970019}, {"lowerIsBetter": false, "replicates": [1111.111111111111], "unit": "score", "name": "RayTrace", "value": 665.9901}, {"lowerIsBetter": false, "replicates": [780.64012490242], "unit": "score", "name": "Earley", "value": 853.7391030000001}, {"lowerIsBetter": false, "replicates": [12084.33734939759], "unit": "score", "name": "Boyer", "value": 55.150976071784655}, {"lowerIsBetter": false, "replicates": [26552.63157894737], "unit": "score", "name": "RegExp", "value": 34.3086521308226}, {"lowerIsBetter": false, "replicates": [597.3715651135007], "unit": "score", "name": "Splay", "value": 136.41593400000002}, {"lowerIsBetter": false, "replicates": [4830.917874396136], "unit": "score", "name": "NavierStokes", "value": 307.1879999999999}], "name": "v8_7", "value": 21056.676654406387}]} 19:09:41 INFO - RETURN: dromaeo_css: 6947.21 19:09:41 INFO - RETURN: kraken: 1500.30 19:09:41 INFO - RETURN: v8_7: 21056.68 19:09:41 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,1,35]]", "result": "21056.68"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,1,35]]", "result": "1500.30"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,1,35]]", "result": "6947.21"}}} 19:09:41 INFO - Return code: 0 19:09:41 INFO - # TBPL SUCCESS # 19:09:41 INFO - Running post-action listener: _resource_record_post_action 19:09:41 INFO - Running post-run listener: _resource_record_post_run 19:09:42 INFO - Total resource usage - Wall time: 1227s; CPU: 13.0%; Read bytes: 0; Write bytes: 500334592; Read time: 0; Write time: 532044 19:09:42 INFO - install - Wall time: 15s; CPU: 14.0%; Read bytes: 0; Write bytes: 229851136; Read time: 0; Write time: 319724 19:09:42 INFO - run-tests - Wall time: 1213s; CPU: 13.0%; Read bytes: 0; Write bytes: 270450688; Read time: 0; Write time: 211220 19:09:42 INFO - Running post-run listener: _upload_blobber_files 19:09:42 INFO - Blob upload gear active. 19:09:42 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 19:09:42 INFO - Copying logs to upload dir... 19:09:42 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1257.742403 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 57 secs) (at 2015-11-20 19:09:42.163177) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-20 19:09:42.168474) ========= 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=b4e1481c633df10bed3f4cc0000001c7-1448074121.649156-979618878 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/hA8dQlKTS3q2OXhD_wXxZg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.009940 build_url: 'https://queue.taskcluster.net/v1/task/hA8dQlKTS3q2OXhD_wXxZg/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 19:09:42.219250) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-20 19:09:42.219572) ========= 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=b4e1481c633df10bed3f4cc0000001c7-1448074121.649156-979618878 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004476 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-20 19:09:42.269067) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-20 19:09:42.269384) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-20 19:09:42.269684) ========= ========= Total master_lag: 0.21 =========