builder: mozilla-central_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-004 starttime: 1448113190.44 results: success (0) buildid: 20151121030232 builduid: 19fe30bfdb0a4633ad6952d5b4ce1f41 revision: 3f5afaf4e6b72c4b1a20749b4ce7d945add5299f ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-11-21 05:39:50.438023) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-11-21 05:39:50.438540) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-21 05:39:50.439194) ========= 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=8e92d6ac3b8b0dffa3775d33000001f9-1448108862.287650-2094211711 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.008636 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.01 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-21 05:39:50.462610) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-21 05:39:50.462949) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-21 05:39:50.493105) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-21 05:39:50.493423) ========= 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=8e92d6ac3b8b0dffa3775d33000001f9-1448108862.287650-2094211711 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004777 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-21 05:39:50.542600) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-21 05:39:50.542936) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-21 05:39:50.543342) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-21 05:39:50.543666) ========= 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=8e92d6ac3b8b0dffa3775d33000001f9-1448108862.287650-2094211711 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-11-21 05:39:51-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 16.9M=0.001s 2015-11-21 05:39:51 (16.9 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.182213 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-21 05:39:50.739524) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-21 05:39:50.739898) ========= 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=8e92d6ac3b8b0dffa3775d33000001f9-1448108862.287650-2094211711 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019846 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-21 05:39:50.793006) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-21 05:39:50.793370) ========= 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=8e92d6ac3b8b0dffa3775d33000001f9-1448108862.287650-2094211711 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-11-21 05:39:51,398 truncating revision to first 12 chars 2015-11-21 05:39:51,398 Setting DEBUG logging. 2015-11-21 05:39:51,398 attempt 1/10 2015-11-21 05:39:51,398 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-21 05:39:51,975 unpacking tar archive at: mozilla-central-3f5afaf4e6b7/testing/mozharness/ program finished with exit code 0 elapsedTime=0.839533 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-21 05:39:51.651503) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-21 05:39:51.651835) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-21 05:39:51.662417) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-21 05:39:51.662918) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-21 05:39:51.663585) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 6 secs) (at 2015-11-21 05:39:51.664134) ========= /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=8e92d6ac3b8b0dffa3775d33000001f9-1448108862.287650-2094211711 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 05:39:52 INFO - MultiFileLogger online at 20151121 05:39:52 in /builds/slave/test-pgo 05:39:52 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 05:39:52 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 05:39:52 INFO - {'append_to_log': False, 05:39:52 INFO - 'base_work_dir': '/builds/slave/test-pgo', 05:39:52 INFO - 'blob_upload_branch': 'Firefox', 05:39:52 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 05:39:52 INFO - 'branch': 'Firefox', 05:39:52 INFO - 'buildbot_json_path': 'buildprops.json', 05:39:52 INFO - 'config_files': ('talos/linux_config.py',), 05:39:52 INFO - 'default_actions': ('clobber', 05:39:52 INFO - 'read-buildbot-config', 05:39:52 INFO - 'download-and-extract', 05:39:52 INFO - 'populate-webroot', 05:39:52 INFO - 'create-virtualenv', 05:39:52 INFO - 'install', 05:39:52 INFO - 'run-tests'), 05:39:52 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:39:52 INFO - 'download_minidump_stackwalk': True, 05:39:52 INFO - 'download_symbols': 'ondemand', 05:39:52 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:39:52 INFO - 'tooltool.py': '/tools/tooltool.py', 05:39:52 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:39:52 INFO - '/tools/misc-python/virtualenv.py')}, 05:39:52 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:39:52 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:39:52 INFO - 'installer_path': 'installer.exe', 05:39:52 INFO - 'log_level': 'info', 05:39:52 INFO - 'log_name': 'talos', 05:39:52 INFO - 'log_to_console': True, 05:39:52 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 05:39:52 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 05:39:52 INFO - 'opt_config_files': (), 05:39:52 INFO - 'pip_index': False, 05:39:52 INFO - 'sps_profile': False, 05:39:52 INFO - 'sps_profile_interval': 0, 05:39:52 INFO - 'suite': 'dromaeojs', 05:39:52 INFO - 'system_bits': '64', 05:39:52 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:39:52 INFO - 'title': 'talos-linux64-ix-004', 05:39:52 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:39:52 INFO - 'use_talos_json': True, 05:39:52 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 05:39:52 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:39:52 INFO - 'work_dir': 'build'} 05:39:52 INFO - ##### 05:39:52 INFO - ##### Running clobber step. 05:39:52 INFO - ##### 05:39:52 INFO - Running pre-action listener: _resource_record_pre_action 05:39:52 INFO - Running main action method: clobber 05:39:52 INFO - rmtree: /builds/slave/test-pgo/build 05:39:52 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 05:39:52 INFO - Running post-action listener: _resource_record_post_action 05:39:52 INFO - ##### 05:39:52 INFO - ##### Running read-buildbot-config step. 05:39:52 INFO - ##### 05:39:52 INFO - Running pre-action listener: _resource_record_pre_action 05:39:52 INFO - Running main action method: read_buildbot_config 05:39:52 INFO - Using buildbot properties: 05:39:52 INFO - { 05:39:52 INFO - "properties": { 05:39:52 INFO - "buildnumber": 118, 05:39:52 INFO - "product": "firefox", 05:39:52 INFO - "script_repo_revision": "production", 05:39:52 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 05:39:52 INFO - "repository": "", 05:39:52 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs", 05:39:52 INFO - "buildid": "20151121030232", 05:39:52 INFO - "slavename": "talos-linux64-ix-004", 05:39:52 INFO - "stage_platform": "linux64-pgo", 05:39:52 INFO - "basedir": "/builds/slave/test-pgo", 05:39:52 INFO - "nightly_build": "True", 05:39:52 INFO - "project": "", 05:39:52 INFO - "platform": "ubuntu64_hw", 05:39:52 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 05:39:52 INFO - "slavebuilddir": "test", 05:39:52 INFO - "scheduler": "tests-mozilla-central-linux64-pgo-talos", 05:39:52 INFO - "branch": "mozilla-central", 05:39:52 INFO - "repo_path": "mozilla-central", 05:39:52 INFO - "pgo_build": "True", 05:39:52 INFO - "builduid": "19fe30bfdb0a4633ad6952d5b4ce1f41", 05:39:52 INFO - "revision": "3f5afaf4e6b72c4b1a20749b4ce7d945add5299f" 05:39:52 INFO - }, 05:39:52 INFO - "sourcestamp": { 05:39:52 INFO - "repository": "", 05:39:52 INFO - "hasPatch": false, 05:39:52 INFO - "project": "", 05:39:52 INFO - "branch": "mozilla-central-linux64-pgo-talos", 05:39:52 INFO - "changes": [ 05:39:52 INFO - { 05:39:52 INFO - "category": null, 05:39:52 INFO - "files": [ 05:39:52 INFO - { 05:39:52 INFO - "url": null, 05:39:52 INFO - "name": "https://queue.taskcluster.net/v1/task/xCuxb0UzSd-WXWD66VASLA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2" 05:39:52 INFO - } 05:39:52 INFO - ], 05:39:52 INFO - "repository": "", 05:39:52 INFO - "rev": "3f5afaf4e6b72c4b1a20749b4ce7d945add5299f", 05:39:52 INFO - "who": "sendchange", 05:39:52 INFO - "when": 1448113153, 05:39:52 INFO - "number": 6692409, 05:39:52 INFO - "comments": "", 05:39:52 INFO - "project": "", 05:39:52 INFO - "at": "Sat 21 Nov 2015 05:39:13", 05:39:52 INFO - "branch": "mozilla-central-linux64-pgo-talos", 05:39:52 INFO - "revlink": "", 05:39:52 INFO - "properties": [ 05:39:52 INFO - [ 05:39:52 INFO - "buildid", 05:39:52 INFO - "20151121030232", 05:39:52 INFO - "Change" 05:39:52 INFO - ], 05:39:52 INFO - [ 05:39:52 INFO - "builduid", 05:39:52 INFO - "19fe30bfdb0a4633ad6952d5b4ce1f41", 05:39:52 INFO - "Change" 05:39:52 INFO - ], 05:39:52 INFO - [ 05:39:52 INFO - "nightly_build", 05:39:52 INFO - "True", 05:39:52 INFO - "Change" 05:39:52 INFO - ], 05:39:52 INFO - [ 05:39:52 INFO - "pgo_build", 05:39:52 INFO - "True", 05:39:52 INFO - "Change" 05:39:52 INFO - ] 05:39:52 INFO - ], 05:39:52 INFO - "revision": "3f5afaf4e6b72c4b1a20749b4ce7d945add5299f" 05:39:52 INFO - } 05:39:52 INFO - ], 05:39:52 INFO - "revision": "3f5afaf4e6b72c4b1a20749b4ce7d945add5299f" 05:39:52 INFO - } 05:39:52 INFO - } 05:39:52 INFO - Found installer url https://queue.taskcluster.net/v1/task/xCuxb0UzSd-WXWD66VASLA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2. 05:39:52 INFO - Running post-action listener: _resource_record_post_action 05:39:52 INFO - ##### 05:39:52 INFO - ##### Running download-and-extract step. 05:39:52 INFO - ##### 05:39:52 INFO - Running pre-action listener: _resource_record_pre_action 05:39:52 INFO - Running main action method: download_and_extract 05:39:52 INFO - mkdir: /builds/slave/test-pgo/build/tests 05:39:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:39:52 INFO - https://queue.taskcluster.net/v1/task/xCuxb0UzSd-WXWD66VASLA/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 05:39:52 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/xCuxb0UzSd-WXWD66VASLA/artifacts/public/build/test_packages.json 05:39:52 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/xCuxb0UzSd-WXWD66VASLA/artifacts/public/build/test_packages.json 05:39:52 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/xCuxb0UzSd-WXWD66VASLA/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 05:39:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/xCuxb0UzSd-WXWD66VASLA/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 05:39:56 INFO - Downloaded 1302 bytes. 05:39:56 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 05:39:56 INFO - Using the following test package requirements: 05:39:56 INFO - {u'common': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 05:39:56 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 05:39:56 INFO - u'firefox-45.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 05:39:56 INFO - u'jittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 05:39:56 INFO - u'jsshell-linux-x86_64.zip'], 05:39:56 INFO - u'mochitest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 05:39:56 INFO - u'firefox-45.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 05:39:56 INFO - u'mozbase': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 05:39:56 INFO - u'reftest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 05:39:56 INFO - u'firefox-45.0a1.en-US.linux-x86_64.reftest.tests.zip'], 05:39:56 INFO - u'talos': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 05:39:56 INFO - u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'], 05:39:56 INFO - u'web-platform': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 05:39:56 INFO - u'firefox-45.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 05:39:56 INFO - u'webapprt': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 05:39:56 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 05:39:56 INFO - u'firefox-45.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 05:39:56 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 05:39:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:39:56 INFO - https://queue.taskcluster.net/v1/task/xCuxb0UzSd-WXWD66VASLA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:39:56 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/xCuxb0UzSd-WXWD66VASLA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 05:39:56 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/xCuxb0UzSd-WXWD66VASLA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 05:39:56 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/xCuxb0UzSd-WXWD66VASLA/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 05:39:56 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/xCuxb0UzSd-WXWD66VASLA/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 05:40:00 INFO - Downloaded 22523631 bytes. 05:40:00 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test-pgo/build/tests 05:40:00 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 05:40:00 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 05:40:02 INFO - Return code: 0 05:40:02 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 05:40:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:40:02 INFO - https://queue.taskcluster.net/v1/task/xCuxb0UzSd-WXWD66VASLA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:40:02 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/xCuxb0UzSd-WXWD66VASLA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 05:40:02 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/xCuxb0UzSd-WXWD66VASLA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 05:40:02 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/xCuxb0UzSd-WXWD66VASLA/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 05:40:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/xCuxb0UzSd-WXWD66VASLA/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 05:40:07 INFO - Downloaded 22523631 bytes. 05:40:07 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 05:40:07 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 05:40:07 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 05:40:08 INFO - Return code: 0 05:40:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:40:08 INFO - https://queue.taskcluster.net/v1/task/xCuxb0UzSd-WXWD66VASLA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 05:40:08 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/xCuxb0UzSd-WXWD66VASLA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 05:40:08 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/xCuxb0UzSd-WXWD66VASLA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 05:40:08 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/xCuxb0UzSd-WXWD66VASLA/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 05:40:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/xCuxb0UzSd-WXWD66VASLA/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 05:40:10 INFO - Downloaded 11130997 bytes. 05:40:10 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 05:40:10 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 05:40:10 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 05:40:10 INFO - Return code: 0 05:40:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:40:10 INFO - https://queue.taskcluster.net/v1/task/xCuxb0UzSd-WXWD66VASLA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 05:40:10 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/xCuxb0UzSd-WXWD66VASLA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 05:40:10 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/xCuxb0UzSd-WXWD66VASLA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 05:40:10 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/xCuxb0UzSd-WXWD66VASLA/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 05:40:10 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/xCuxb0UzSd-WXWD66VASLA/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 05:40:11 INFO - Downloaded 57434606 bytes. 05:40:11 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/xCuxb0UzSd-WXWD66VASLA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 05:40:11 INFO - mkdir: /builds/slave/test-pgo/properties 05:40:11 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 05:40:11 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 05:40:11 INFO - Contents: 05:40:11 INFO - build_url:https://queue.taskcluster.net/v1/task/xCuxb0UzSd-WXWD66VASLA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 05:40:11 INFO - Running post-action listener: _resource_record_post_action 05:40:11 INFO - Running post-action listener: set_extra_try_arguments 05:40:11 INFO - ##### 05:40:11 INFO - ##### Running populate-webroot step. 05:40:11 INFO - ##### 05:40:11 INFO - Running pre-action listener: _resource_record_pre_action 05:40:11 INFO - Running main action method: populate_webroot 05:40:11 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:40:11 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:40:11 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 05:40:11 INFO - '../fennec_ids.txt'], 05:40:11 INFO - 'tests': ['tcheck2']}, 05:40:11 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:40:11 INFO - '--tppagecycles', 05:40:11 INFO - '7'], 05:40:11 INFO - 'tests': ['tsvgm']}}, 05:40:11 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 05:40:11 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 05:40:11 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:40:11 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 05:40:11 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 05:40:11 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 05:40:11 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:40:11 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:40:11 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:40:11 INFO - 'talos_options': ['--e10s'], 05:40:11 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:40:11 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:40:11 INFO - 'tests': ['damp', 'tps']}, 05:40:11 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:40:11 INFO - 'talos_options': ['--e10s'], 05:40:11 INFO - 'tests': ['damp', 'tps']}, 05:40:11 INFO - 'g3': {'tests': ['dromaeo_dom']}, 05:40:11 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:40:11 INFO - 'other': {'tests': ['a11yr', 05:40:11 INFO - 'ts_paint', 05:40:11 INFO - 'tpaint', 05:40:11 INFO - 'sessionrestore', 05:40:11 INFO - 'sessionrestore_no_auto_restore']}, 05:40:11 INFO - 'other-e10s': {'talos_options': ['--e10s'], 05:40:11 INFO - 'tests': ['a11yr', 05:40:11 INFO - 'ts_paint', 05:40:11 INFO - 'tpaint', 05:40:11 INFO - 'sessionrestore', 05:40:11 INFO - 'sessionrestore_no_auto_restore']}, 05:40:11 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 05:40:11 INFO - 'tests': ['a11yr', 05:40:11 INFO - 'ts_paint', 05:40:11 INFO - 'tpaint', 05:40:11 INFO - 'sessionrestore', 05:40:11 INFO - 'sessionrestore_no_auto_restore']}, 05:40:11 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 05:40:11 INFO - 'tests': ['a11yr', 05:40:11 INFO - 'ts_paint', 05:40:11 INFO - 'tpaint', 05:40:11 INFO - 'sessionrestore', 05:40:11 INFO - 'sessionrestore_no_auto_restore']}, 05:40:11 INFO - 'other_l64': {'tests': ['a11yr', 05:40:11 INFO - 'ts_paint', 05:40:11 INFO - 'tpaint', 05:40:11 INFO - 'sessionrestore', 05:40:11 INFO - 'sessionrestore_no_auto_restore']}, 05:40:11 INFO - 'other_nol64': {'tests': ['a11yr', 05:40:11 INFO - 'ts_paint', 05:40:11 INFO - 'tpaint', 05:40:11 INFO - 'sessionrestore', 05:40:11 INFO - 'sessionrestore_no_auto_restore']}, 05:40:11 INFO - 'svgr': {'tests': ['tsvgx', 05:40:11 INFO - 'tsvgr_opacity', 05:40:11 INFO - 'tart', 05:40:11 INFO - 'tscrollx', 05:40:11 INFO - 'cart']}, 05:40:11 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 05:40:11 INFO - 'tests': ['tsvgx', 05:40:11 INFO - 'tsvgr_opacity', 05:40:11 INFO - 'tart', 05:40:11 INFO - 'tscrollx', 05:40:11 INFO - 'cart']}, 05:40:11 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:40:11 INFO - 'tests': ['tp5o']}, 05:40:11 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:40:11 INFO - 'talos_options': ['--e10s'], 05:40:11 INFO - 'tests': ['tp5o']}, 05:40:11 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:40:11 INFO - 'talos_options': ['--xperf_path', 05:40:11 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:40:11 INFO - 'tests': ['tp5n']}, 05:40:11 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:40:11 INFO - 'talos_options': ['--e10s', 05:40:11 INFO - '--xperf_path', 05:40:11 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:40:11 INFO - 'tests': ['tp5n']}}, 05:40:11 INFO - 'talos.zip': {'path': '', 05:40:11 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:40:11 INFO - Running post-action listener: _resource_record_post_action 05:40:11 INFO - ##### 05:40:11 INFO - ##### Running create-virtualenv step. 05:40:11 INFO - ##### 05:40:11 INFO - Running pre-action listener: _resource_record_pre_action 05:40:11 INFO - Running main action method: create_virtualenv 05:40:11 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 05:40:11 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 05:40:11 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 05:40:11 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:40:11 INFO - Using real prefix '/usr' 05:40:11 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 05:40:12 INFO - Installing distribute.............................................................................................................................................................................................done. 05:40:14 INFO - Installing pip.................done. 05:40:14 INFO - Return code: 0 05:40:14 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 05:40:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:40:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:40:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:40:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:40:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:40:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:40:14 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa2de704c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21e76c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22a86e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22dea90>, '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 0x2330f70>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23312e0>, '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': '8e92d6ac3b8b0dffa3775d33000001f9-1448108862.287650-2094211711', '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 05:40:14 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test-pgo/build 05:40:14 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 05:40:14 INFO - Using env: {'DISPLAY': ':0', 05:40:14 INFO - 'HOME': '/home/cltbld', 05:40:14 INFO - 'LANG': 'en_US.UTF-8', 05:40:14 INFO - 'LANGUAGE': 'en_US:en', 05:40:14 INFO - 'LOGNAME': 'cltbld', 05:40:14 INFO - 'MAIL': '/var/mail/cltbld', 05:40:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:40:14 INFO - 'MOZ_NO_REMOTE': '1', 05:40:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:40:14 INFO - 'NO_EM_RESTART': '1', 05:40:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:40:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:40:14 INFO - 'PWD': '/builds/slave/test-pgo', 05:40:14 INFO - 'SHELL': '/bin/bash', 05:40:14 INFO - 'SHLVL': '1', 05:40:14 INFO - 'TERM': 'linux', 05:40:14 INFO - 'TMOUT': '86400', 05:40:14 INFO - 'USER': 'cltbld', 05:40:14 INFO - 'XDG_SESSION_COOKIE': '8e92d6ac3b8b0dffa3775d33000001f9-1448108862.287650-2094211711', 05:40:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:40:14 INFO - '_': '/tools/buildbot/bin/python'} 05:40:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:40:14 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 05:40:14 INFO - Cleaning up... 05:40:14 INFO - Return code: 0 05:40:14 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 05:40:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:40:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:40:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:40:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:40:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:40:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:40:14 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fa2de704c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21e76c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22a86e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22dea90>, '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 0x2330f70>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23312e0>, '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': '8e92d6ac3b8b0dffa3775d33000001f9-1448108862.287650-2094211711', '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 05:40:14 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test-pgo/build 05:40:14 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 05:40:14 INFO - Using env: {'DISPLAY': ':0', 05:40:14 INFO - 'HOME': '/home/cltbld', 05:40:14 INFO - 'LANG': 'en_US.UTF-8', 05:40:14 INFO - 'LANGUAGE': 'en_US:en', 05:40:14 INFO - 'LOGNAME': 'cltbld', 05:40:14 INFO - 'MAIL': '/var/mail/cltbld', 05:40:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:40:14 INFO - 'MOZ_NO_REMOTE': '1', 05:40:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:40:14 INFO - 'NO_EM_RESTART': '1', 05:40:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:40:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:40:14 INFO - 'PWD': '/builds/slave/test-pgo', 05:40:14 INFO - 'SHELL': '/bin/bash', 05:40:14 INFO - 'SHLVL': '1', 05:40:14 INFO - 'TERM': 'linux', 05:40:14 INFO - 'TMOUT': '86400', 05:40:14 INFO - 'USER': 'cltbld', 05:40:14 INFO - 'XDG_SESSION_COOKIE': '8e92d6ac3b8b0dffa3775d33000001f9-1448108862.287650-2094211711', 05:40:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:40:14 INFO - '_': '/tools/buildbot/bin/python'} 05:40:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:40:14 INFO - Downloading/unpacking psutil>=0.7.1 05:40:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:40:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:40:14 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 05:40:14 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 05:40:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:40:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:40:16 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 05:40:16 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 05:40:16 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 05:40:16 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:40:16 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:40:16 INFO - Installing collected packages: psutil 05:40:16 INFO - Running setup.py install for psutil 05:40:16 INFO - building 'psutil._psutil_linux' extension 05:40:16 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 05:40:16 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 05:40:16 INFO - building 'psutil._psutil_posix' extension 05:40:16 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 05:40:17 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 05:40:17 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:40:17 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:40:17 INFO - Successfully installed psutil 05:40:17 INFO - Cleaning up... 05:40:17 INFO - Return code: 0 05:40:17 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 05:40:17 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')]} 05:40:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:40:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:40:17 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')]} 05:40:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:40:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:40:17 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 0x7fa2de704c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21e76c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22a86e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22dea90>, '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 0x2330f70>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23312e0>, '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': '8e92d6ac3b8b0dffa3775d33000001f9-1448108862.287650-2094211711', '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 05:40:17 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 05:40:17 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 05:40:17 INFO - Using env: {'DISPLAY': ':0', 05:40:17 INFO - 'HOME': '/home/cltbld', 05:40:17 INFO - 'LANG': 'en_US.UTF-8', 05:40:17 INFO - 'LANGUAGE': 'en_US:en', 05:40:17 INFO - 'LOGNAME': 'cltbld', 05:40:17 INFO - 'MAIL': '/var/mail/cltbld', 05:40:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:40:17 INFO - 'MOZ_NO_REMOTE': '1', 05:40:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:40:17 INFO - 'NO_EM_RESTART': '1', 05:40:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:40:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:40:17 INFO - 'PWD': '/builds/slave/test-pgo', 05:40:17 INFO - 'SHELL': '/bin/bash', 05:40:17 INFO - 'SHLVL': '1', 05:40:17 INFO - 'TERM': 'linux', 05:40:17 INFO - 'TMOUT': '86400', 05:40:17 INFO - 'USER': 'cltbld', 05:40:17 INFO - 'XDG_SESSION_COOKIE': '8e92d6ac3b8b0dffa3775d33000001f9-1448108862.287650-2094211711', 05:40:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:40:17 INFO - '_': '/tools/buildbot/bin/python'} 05:40:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:40:17 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 05:40:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:40:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:40:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:40:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:40:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:40:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:40:19 INFO - Downloading mozsystemmonitor-0.0.tar.gz 05:40:19 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 05:40:19 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:40:19 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 05:40:19 INFO - Installing collected packages: mozsystemmonitor 05:40:19 INFO - Running setup.py install for mozsystemmonitor 05:40:19 INFO - Successfully installed mozsystemmonitor 05:40:19 INFO - Cleaning up... 05:40:19 INFO - Return code: 0 05:40:19 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 05:40:19 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')]} 05:40:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:40:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:40:19 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')]} 05:40:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:40:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:40:19 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 0x7fa2de704c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21e76c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22a86e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22dea90>, '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 0x2330f70>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23312e0>, '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': '8e92d6ac3b8b0dffa3775d33000001f9-1448108862.287650-2094211711', '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 05:40:19 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 05:40:19 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 05:40:19 INFO - Using env: {'DISPLAY': ':0', 05:40:19 INFO - 'HOME': '/home/cltbld', 05:40:19 INFO - 'LANG': 'en_US.UTF-8', 05:40:19 INFO - 'LANGUAGE': 'en_US:en', 05:40:19 INFO - 'LOGNAME': 'cltbld', 05:40:19 INFO - 'MAIL': '/var/mail/cltbld', 05:40:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:40:19 INFO - 'MOZ_NO_REMOTE': '1', 05:40:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:40:19 INFO - 'NO_EM_RESTART': '1', 05:40:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:40:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:40:19 INFO - 'PWD': '/builds/slave/test-pgo', 05:40:19 INFO - 'SHELL': '/bin/bash', 05:40:19 INFO - 'SHLVL': '1', 05:40:19 INFO - 'TERM': 'linux', 05:40:19 INFO - 'TMOUT': '86400', 05:40:19 INFO - 'USER': 'cltbld', 05:40:19 INFO - 'XDG_SESSION_COOKIE': '8e92d6ac3b8b0dffa3775d33000001f9-1448108862.287650-2094211711', 05:40:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:40:19 INFO - '_': '/tools/buildbot/bin/python'} 05:40:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:40:19 INFO - Downloading/unpacking blobuploader==1.2.4 05:40:19 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 05:40:19 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 05:40:19 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 05:40:19 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 05:40:19 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 05:40:19 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 05:40:21 INFO - Downloading blobuploader-1.2.4.tar.gz 05:40:21 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 05:40:21 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:40:21 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:40:21 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 05:40:21 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 05:40:21 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 05:40:21 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 05:40:21 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 05:40:21 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 05:40:21 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 05:40:21 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 05:40:21 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:40:21 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 05:40:21 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 05:40:21 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 05:40:21 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 05:40:21 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 05:40:21 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 05:40:21 INFO - Downloading docopt-0.6.1.tar.gz 05:40:21 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 05:40:21 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 05:40:21 INFO - Installing collected packages: blobuploader, requests, docopt 05:40:21 INFO - Running setup.py install for blobuploader 05:40:21 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:40:21 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 05:40:21 INFO - Running setup.py install for requests 05:40:22 INFO - Running setup.py install for docopt 05:40:22 INFO - Successfully installed blobuploader requests docopt 05:40:22 INFO - Cleaning up... 05:40:22 INFO - Return code: 0 05:40:22 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 05:40:22 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')]} 05:40:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:40:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:40:22 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')]} 05:40:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:40:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:40:22 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 0x7fa2de704c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21e76c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22a86e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22dea90>, '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 0x2330f70>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23312e0>, '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': '8e92d6ac3b8b0dffa3775d33000001f9-1448108862.287650-2094211711', '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 05:40:22 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 05:40:22 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 05:40:22 INFO - Using env: {'DISPLAY': ':0', 05:40:22 INFO - 'HOME': '/home/cltbld', 05:40:22 INFO - 'LANG': 'en_US.UTF-8', 05:40:22 INFO - 'LANGUAGE': 'en_US:en', 05:40:22 INFO - 'LOGNAME': 'cltbld', 05:40:22 INFO - 'MAIL': '/var/mail/cltbld', 05:40:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:40:22 INFO - 'MOZ_NO_REMOTE': '1', 05:40:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:40:22 INFO - 'NO_EM_RESTART': '1', 05:40:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:40:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:40:22 INFO - 'PWD': '/builds/slave/test-pgo', 05:40:22 INFO - 'SHELL': '/bin/bash', 05:40:22 INFO - 'SHLVL': '1', 05:40:22 INFO - 'TERM': 'linux', 05:40:22 INFO - 'TMOUT': '86400', 05:40:22 INFO - 'USER': 'cltbld', 05:40:22 INFO - 'XDG_SESSION_COOKIE': '8e92d6ac3b8b0dffa3775d33000001f9-1448108862.287650-2094211711', 05:40:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:40:22 INFO - '_': '/tools/buildbot/bin/python'} 05:40:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:40:22 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 05:40:22 INFO - Running setup.py (path:/tmp/pip-2vAj3b-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 05:40:22 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 05:40:22 INFO - Running setup.py (path:/tmp/pip-4Gl8Cg-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 05:40:22 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 05:40:22 INFO - Running setup.py (path:/tmp/pip-IGHZMB-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 05:40:22 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 05:40:22 INFO - Running setup.py (path:/tmp/pip-6ccZXX-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 05:40:22 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 05:40:22 INFO - Running setup.py (path:/tmp/pip-vau78a-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 05:40:23 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 05:40:23 INFO - Running setup.py (path:/tmp/pip-GjM43P-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 05:40:23 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 05:40:23 INFO - Running setup.py (path:/tmp/pip-EO8ch9-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 05:40:23 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 05:40:23 INFO - Running setup.py (path:/tmp/pip-g_ablU-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 05:40:23 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 05:40:23 INFO - Running setup.py (path:/tmp/pip-6RBrXt-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 05:40:23 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 05:40:23 INFO - Running setup.py (path:/tmp/pip-SZBmWs-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 05:40:23 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 05:40:23 INFO - Running setup.py (path:/tmp/pip-Fu4OqZ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 05:40:23 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 05:40:23 INFO - Running setup.py (path:/tmp/pip-kwHn2y-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 05:40:23 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 05:40:23 INFO - Running setup.py (path:/tmp/pip-Dvz37z-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 05:40:23 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 05:40:23 INFO - Running setup.py (path:/tmp/pip-2BE5_9-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 05:40:23 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 05:40:23 INFO - Running setup.py (path:/tmp/pip-Kq24Hw-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 05:40:23 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 05:40:23 INFO - Running setup.py (path:/tmp/pip-ctHz0D-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 05:40:23 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 05:40:23 INFO - Running setup.py (path:/tmp/pip-aVrLVd-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 05:40:23 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:40:23 INFO - Running setup.py install for manifestparser 05:40:23 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 05:40:24 INFO - Running setup.py install for mozcrash 05:40:24 INFO - Running setup.py install for mozdebug 05:40:24 INFO - Running setup.py install for mozdevice 05:40:24 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 05:40:24 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 05:40:24 INFO - Running setup.py install for mozfile 05:40:24 INFO - Running setup.py install for mozhttpd 05:40:24 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 05:40:24 INFO - Running setup.py install for mozinfo 05:40:24 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 05:40:24 INFO - Running setup.py install for mozInstall 05:40:24 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 05:40:24 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 05:40:24 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 05:40:24 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 05:40:24 INFO - Running setup.py install for mozleak 05:40:24 INFO - Running setup.py install for mozlog 05:40:24 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 05:40:24 INFO - Running setup.py install for moznetwork 05:40:25 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 05:40:25 INFO - Running setup.py install for mozprocess 05:40:25 INFO - Running setup.py install for mozprofile 05:40:25 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 05:40:25 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 05:40:25 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 05:40:25 INFO - Running setup.py install for mozrunner 05:40:25 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 05:40:25 INFO - Running setup.py install for mozscreenshot 05:40:25 INFO - Running setup.py install for moztest 05:40:25 INFO - Running setup.py install for mozversion 05:40:25 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 05:40:25 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:40:25 INFO - Cleaning up... 05:40:25 INFO - Return code: 0 05:40:25 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 05:40:25 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')]} 05:40:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:40:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:40:25 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')]} 05:40:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:40:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:40:25 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 0x7fa2de704c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21e76c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22a86e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22dea90>, '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 0x2330f70>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23312e0>, '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': '8e92d6ac3b8b0dffa3775d33000001f9-1448108862.287650-2094211711', '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 05:40:25 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 05:40:25 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 05:40:25 INFO - Using env: {'DISPLAY': ':0', 05:40:25 INFO - 'HOME': '/home/cltbld', 05:40:25 INFO - 'LANG': 'en_US.UTF-8', 05:40:25 INFO - 'LANGUAGE': 'en_US:en', 05:40:25 INFO - 'LOGNAME': 'cltbld', 05:40:25 INFO - 'MAIL': '/var/mail/cltbld', 05:40:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:40:25 INFO - 'MOZ_NO_REMOTE': '1', 05:40:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:40:25 INFO - 'NO_EM_RESTART': '1', 05:40:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:40:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:40:25 INFO - 'PWD': '/builds/slave/test-pgo', 05:40:25 INFO - 'SHELL': '/bin/bash', 05:40:25 INFO - 'SHLVL': '1', 05:40:25 INFO - 'TERM': 'linux', 05:40:25 INFO - 'TMOUT': '86400', 05:40:25 INFO - 'USER': 'cltbld', 05:40:25 INFO - 'XDG_SESSION_COOKIE': '8e92d6ac3b8b0dffa3775d33000001f9-1448108862.287650-2094211711', 05:40:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:40:25 INFO - '_': '/tools/buildbot/bin/python'} 05:40:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:40:25 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 05:40:25 INFO - Running setup.py (path:/tmp/pip-xiuBiX-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 05:40:25 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)) 05:40:25 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 05:40:25 INFO - Running setup.py (path:/tmp/pip-852Jtb-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 05:40:26 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)) 05:40:26 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 05:40:26 INFO - Running setup.py (path:/tmp/pip-w2PVti-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 05:40:26 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)) 05:40:26 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 05:40:26 INFO - Running setup.py (path:/tmp/pip-J13yXJ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 05:40:26 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)) 05:40:26 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 05:40:26 INFO - Running setup.py (path:/tmp/pip-dykGvK-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 05:40:26 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)) 05:40:26 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 05:40:26 INFO - Running setup.py (path:/tmp/pip-kFLFLi-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 05:40:26 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)) 05:40:26 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 05:40:26 INFO - Running setup.py (path:/tmp/pip-loMohu-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 05:40:26 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)) 05:40:26 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 05:40:26 INFO - Running setup.py (path:/tmp/pip-spdtzZ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 05:40:26 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)) 05:40:26 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 05:40:26 INFO - Running setup.py (path:/tmp/pip-RL2qy3-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 05:40:26 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)) 05:40:26 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 05:40:26 INFO - Running setup.py (path:/tmp/pip-WaHPEx-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 05:40:26 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)) 05:40:26 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 05:40:26 INFO - Running setup.py (path:/tmp/pip-5nrSgZ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 05:40:26 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)) 05:40:26 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 05:40:26 INFO - Running setup.py (path:/tmp/pip-GlfKhd-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 05:40:26 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)) 05:40:26 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 05:40:26 INFO - Running setup.py (path:/tmp/pip-jkUEqn-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 05:40:26 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)) 05:40:26 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 05:40:26 INFO - Running setup.py (path:/tmp/pip-QYabGz-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 05:40:26 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)) 05:40:26 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 05:40:26 INFO - Running setup.py (path:/tmp/pip-Rw85JH-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 05:40:26 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)) 05:40:26 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 05:40:27 INFO - Running setup.py (path:/tmp/pip-F9Axfy-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 05:40:27 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)) 05:40:27 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 05:40:27 INFO - Running setup.py (path:/tmp/pip-d63i9y-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 05:40:27 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)) 05:40:27 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)) 05:40:27 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)) 05:40:27 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)) 05:40:27 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)) 05:40:27 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)) 05:40:27 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.0->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 05:40:27 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 05:40:27 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 05:40:27 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 05:40:27 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 05:40:27 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 05:40:27 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 05:40:28 INFO - Downloading blessings-1.5.1.tar.gz 05:40:28 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 05:40:28 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 05:40:28 INFO - Installing collected packages: blessings 05:40:28 INFO - Running setup.py install for blessings 05:40:28 INFO - Successfully installed blessings 05:40:28 INFO - Cleaning up... 05:40:29 INFO - Return code: 0 05:40:29 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 05:40:29 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 05:40:29 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 05:40:29 INFO - Reading from file tmpfile_stdout 05:40:29 INFO - Current package versions: 05:40:29 INFO - argparse == 1.2.1 05:40:29 INFO - blessings == 1.5.1 05:40:29 INFO - blobuploader == 1.2.4 05:40:29 INFO - docopt == 0.6.1 05:40:29 INFO - manifestparser == 1.1 05:40:29 INFO - mozInstall == 1.12 05:40:29 INFO - mozcrash == 0.16 05:40:29 INFO - mozdebug == 0.1 05:40:29 INFO - mozdevice == 0.47 05:40:29 INFO - mozfile == 1.2 05:40:29 INFO - mozhttpd == 0.7 05:40:29 INFO - mozinfo == 0.9 05:40:29 INFO - mozleak == 0.1 05:40:29 INFO - mozlog == 3.0 05:40:29 INFO - moznetwork == 0.27 05:40:29 INFO - mozprocess == 0.22 05:40:29 INFO - mozprofile == 0.27 05:40:29 INFO - mozrunner == 6.11 05:40:29 INFO - mozscreenshot == 0.1 05:40:29 INFO - mozsystemmonitor == 0.0 05:40:29 INFO - moztest == 0.7 05:40:29 INFO - mozversion == 1.4 05:40:29 INFO - psutil == 3.1.1 05:40:29 INFO - requests == 1.2.3 05:40:29 INFO - wsgiref == 0.1.2 05:40:29 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 05:40:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:40:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:40:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:40:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:40:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:40:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:40:29 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 0x7fa2de704c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21e76c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22a86e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22dea90>, '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 0x2330f70>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23312e0>, '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': '8e92d6ac3b8b0dffa3775d33000001f9-1448108862.287650-2094211711', '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 05:40:29 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 05:40:29 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 05:40:29 INFO - Using env: {'DISPLAY': ':0', 05:40:29 INFO - 'HOME': '/home/cltbld', 05:40:29 INFO - 'LANG': 'en_US.UTF-8', 05:40:29 INFO - 'LANGUAGE': 'en_US:en', 05:40:29 INFO - 'LOGNAME': 'cltbld', 05:40:29 INFO - 'MAIL': '/var/mail/cltbld', 05:40:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:40:29 INFO - 'MOZ_NO_REMOTE': '1', 05:40:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:40:29 INFO - 'NO_EM_RESTART': '1', 05:40:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:40:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:40:29 INFO - 'PWD': '/builds/slave/test-pgo', 05:40:29 INFO - 'SHELL': '/bin/bash', 05:40:29 INFO - 'SHLVL': '1', 05:40:29 INFO - 'TERM': 'linux', 05:40:29 INFO - 'TMOUT': '86400', 05:40:29 INFO - 'USER': 'cltbld', 05:40:29 INFO - 'XDG_SESSION_COOKIE': '8e92d6ac3b8b0dffa3775d33000001f9-1448108862.287650-2094211711', 05:40:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:40:29 INFO - '_': '/tools/buildbot/bin/python'} 05:40:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:40:29 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)) 05:40:29 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)) 05:40:29 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)) 05:40:29 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)) 05:40:29 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)) 05:40:29 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)) 05:40:29 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)) 05:40:29 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)) 05:40:29 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)) 05:40:29 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)) 05:40:29 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)) 05:40:29 INFO - Cleaning up... 05:40:29 INFO - Return code: 0 05:40:29 INFO - Running post-action listener: _resource_record_post_action 05:40:29 INFO - Running post-action listener: _start_resource_monitoring 05:40:29 INFO - Starting resource monitoring. 05:40:29 INFO - ##### 05:40:29 INFO - ##### Running install step. 05:40:29 INFO - ##### 05:40:29 INFO - Running pre-action listener: _resource_record_pre_action 05:40:29 INFO - Running main action method: install 05:40:29 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 05:40:29 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 05:40:29 INFO - Reading from file tmpfile_stdout 05:40:29 INFO - Detecting whether we're running mozinstall >=1.0... 05:40:29 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 05:40:29 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 05:40:29 INFO - Reading from file tmpfile_stdout 05:40:29 INFO - Output received: 05:40:29 INFO - Usage: mozinstall [options] installer 05:40:29 INFO - Options: 05:40:29 INFO - -h, --help show this help message and exit 05:40:29 INFO - -d DEST, --destination=DEST 05:40:29 INFO - Directory to install application into. [default: 05:40:29 INFO - "/builds/slave/test-pgo"] 05:40:29 INFO - --app=APP Application being installed. [default: firefox] 05:40:29 INFO - mkdir: /builds/slave/test-pgo/build/application 05:40:29 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'] 05:40:29 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 05:40:44 INFO - Reading from file tmpfile_stdout 05:40:44 INFO - Output received: 05:40:44 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 05:40:44 INFO - Running post-action listener: _resource_record_post_action 05:40:44 INFO - ##### 05:40:44 INFO - ##### Running run-tests step. 05:40:44 INFO - ##### 05:40:44 INFO - Running pre-action listener: _resource_record_pre_action 05:40:44 INFO - Running main action method: run_tests 05:40:44 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 05:40:44 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 05:40:44 INFO - Python 2.7.3 05:40:44 INFO - Return code: 0 05:40:44 INFO - grabbing minidump binary from tooltool 05:40:44 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')]} 05:40:44 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 0x22dea90>, '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 0x2330f70>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23312e0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 05:40:44 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 05:40:44 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 05:40:44 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:40:44 INFO - Return code: 0 05:40:44 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 05:40:44 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 05:40:44 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 05:40:44 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 05:40:44 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 05:40:44 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/xCuxb0UzSd-WXWD66VASLA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-004', '--webServer', 'localhost'] in /builds/slave/test-pgo/build 05:40:44 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/xCuxb0UzSd-WXWD66VASLA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-004 --webServer localhost 05:40:44 INFO - Using env: {'DISPLAY': ':0', 05:40:44 INFO - 'HOME': '/home/cltbld', 05:40:44 INFO - 'LANG': 'en_US.UTF-8', 05:40:44 INFO - 'LANGUAGE': 'en_US:en', 05:40:44 INFO - 'LOGNAME': 'cltbld', 05:40:44 INFO - 'MAIL': '/var/mail/cltbld', 05:40:44 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 05:40:44 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 05:40:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:40:44 INFO - 'MOZ_NO_REMOTE': '1', 05:40:44 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 05:40:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:40:44 INFO - 'NO_EM_RESTART': '1', 05:40:44 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:40:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:40:44 INFO - 'PWD': '/builds/slave/test-pgo', 05:40:44 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 05:40:44 INFO - 'SHELL': '/bin/bash', 05:40:44 INFO - 'SHLVL': '1', 05:40:44 INFO - 'TERM': 'linux', 05:40:44 INFO - 'TMOUT': '86400', 05:40:44 INFO - 'USER': 'cltbld', 05:40:44 INFO - 'XDG_SESSION_COOKIE': '8e92d6ac3b8b0dffa3775d33000001f9-1448108862.287650-2094211711', 05:40:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:40:44 INFO - '_': '/tools/buildbot/bin/python'} 05:40:44 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/xCuxb0UzSd-WXWD66VASLA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-004', '--webServer', 'localhost'] with output_timeout 3600 05:40:44 INFO - mozversion INFO | application_buildid: 20151121030232 05:40:44 INFO - mozversion INFO | application_changeset: 3f5afaf4e6b72c4b1a20749b4ce7d945add5299f 05:40:44 INFO - mozversion INFO | application_display_name: Nightly 05:40:44 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:40:44 INFO - mozversion INFO | application_name: Firefox 05:40:44 INFO - mozversion INFO | application_remotingname: firefox 05:40:44 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/mozilla-central 05:40:44 INFO - mozversion INFO | application_vendor: Mozilla 05:40:44 INFO - mozversion INFO | application_version: 45.0a1 05:40:44 INFO - mozversion INFO | platform_buildid: 20151121030232 05:40:44 INFO - mozversion INFO | platform_changeset: 3f5afaf4e6b72c4b1a20749b4ce7d945add5299f 05:40:44 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/mozilla-central 05:40:44 INFO - mozversion INFO | platform_version: 45.0a1 05:40:44 INFO - 2015-11-21 05:40:44,634 DEBUG : using testdate: 1448113244 05:40:44 INFO - 2015-11-21 05:40:44,634 DEBUG : actual date: 1448113244 05:40:44 INFO - 2015-11-21 05:40:44,641 INFO : starting webserver on 'localhost:38986' 05:40:44 INFO - 2015-11-21 05:40:44,642 INFO : Starting test suite talos-linux64-ix-004 05:40:44 INFO - 2015-11-21 05:40:44,642 INFO : Starting test dromaeo_css 05:40:44 INFO - 2015-11-21 05:40:44,642 DEBUG : operating with platform_type : linux_ 05:40:44 INFO - 2015-11-21 05:40:44,642 INFO : Initialising browser for dromaeo_css test... 05:40:44 INFO - 2015-11-21 05:40:44,649 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpnVcFTb/profile http://localhost:38986/getInfo.html 05:40:49 INFO - 2015-11-21 05:40:49,354 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 05:40:49 INFO - 2015-11-21 05:40:49,354 DEBUG : BROWSER_OUTPUT: colorDepth:24 05:40:49 INFO - 2015-11-21 05:40:49,354 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 05:40:49 INFO - 2015-11-21 05:40:49,354 DEBUG : BROWSER_OUTPUT: __metrics 05:40:49 INFO - 2015-11-21 05:40:49,511 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:40:50 INFO - 2015-11-21 05:40:50,718 INFO : Browser initialized. 05:40:50 INFO - 2015-11-21 05:40:50,718 INFO : Running cycle 1/1 for dromaeo_css test... 05:40:50 INFO - 2015-11-21 05:40:50,718 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpnVcFTb/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 05:41:02 INFO - 2015-11-21 05:41:02,493 DEBUG : BROWSER_OUTPUT: RSS: Main: 141332480 05:41:02 INFO - 2015-11-21 05:41:02,493 DEBUG : BROWSER_OUTPUT: 05:41:53 INFO - 2015-11-21 05:41:53,301 DEBUG : BROWSER_OUTPUT: 1448113313300 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] 05:44:03 INFO - 2015-11-21 05:44:03,267 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:38986/tests/dromaeo/cssquery-dojo.html (next: http://localhost:38986/tests/dromaeo/cssquery-ext.html) 05:44:04 INFO - 2015-11-21 05:44:04,503 DEBUG : BROWSER_OUTPUT: RSS: Main: 275267584 05:44:04 INFO - 2015-11-21 05:44:04,503 DEBUG : BROWSER_OUTPUT: 05:47:06 INFO - 2015-11-21 05:47:06,981 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:38986/tests/dromaeo/cssquery-ext.html (next: http://localhost:38986/tests/dromaeo/cssquery-jquery.html) 05:47:07 INFO - 2015-11-21 05:47:07,555 DEBUG : BROWSER_OUTPUT: RSS: Main: 221425664 05:47:07 INFO - 2015-11-21 05:47:07,555 DEBUG : BROWSER_OUTPUT: 05:50:09 INFO - 2015-11-21 05:50:09,422 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:38986/tests/dromaeo/cssquery-jquery.html (next: http://localhost:38986/tests/dromaeo/cssquery-mootools.html) 05:50:09 INFO - 2015-11-21 05:50:09,990 DEBUG : BROWSER_OUTPUT: RSS: Main: 218632192 05:50:09 INFO - 2015-11-21 05:50:09,990 DEBUG : BROWSER_OUTPUT: 05:53:11 INFO - 2015-11-21 05:53:11,800 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:38986/tests/dromaeo/cssquery-mootools.html (next: http://localhost:38986/tests/dromaeo/cssquery-prototype.html) 05:53:12 INFO - 2015-11-21 05:53:12,366 DEBUG : BROWSER_OUTPUT: RSS: Main: 201953280 05:53:12 INFO - 2015-11-21 05:53:12,367 DEBUG : BROWSER_OUTPUT: 05:56:14 INFO - 2015-11-21 05:56:14,866 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:38986/tests/dromaeo/cssquery-prototype.html (next: http://localhost:38986/tests/dromaeo/cssquery-yui.html) 05:56:15 INFO - 2015-11-21 05:56:15,439 DEBUG : BROWSER_OUTPUT: RSS: Main: 202592256 05:56:15 INFO - 2015-11-21 05:56:15,439 DEBUG : BROWSER_OUTPUT: 05:59:18 INFO - 2015-11-21 05:59:18,060 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:38986/tests/dromaeo/cssquery-yui.html (next: http://localhost:38986/tests/dromaeo/cssquery-dojo.html) 05:59:18 INFO - 2015-11-21 05:59:18,306 DEBUG : BROWSER_OUTPUT: RSS: Main: 247685120 05:59:18 INFO - 2015-11-21 05:59:18,306 DEBUG : BROWSER_OUTPUT: 05:59:18 INFO - 2015-11-21 05:59:18,306 DEBUG : BROWSER_OUTPUT: __start_tp_report 05:59:18 INFO - 2015-11-21 05:59:18,306 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 05:59:18 INFO - 2015-11-21 05:59:18,306 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 05:59:18 INFO - 2015-11-21 05:59:18,307 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 05:59:18 INFO - 2015-11-21 05:59:18,308 DEBUG : BROWSER_OUTPUT: |0;dojo.html;3234.110619579616;3283.835808209589;3333.133385319816;3335.5663763710727;3345.3309338132362;5280.366356037281;5432.945670543293;5496.230527726121;5532.308461442315;5536.031194540954;5452.754626041838;5499.862503437406;5537.916931246024;5554.638948468347;5615.354234263061;5014.2979982802435;5031.949680503185;5042.218456139304;5065.164247899111;5092.694438333693;4902.338184345103;5084.771185296652;5148.485151484841;5167.534921857032;5242.580593552507;5006.899862002758;5014.323066386028;5112.130937740593;5142.640015198937;5152.871178220537;5089.134847076006;5098.643094983353;5100.7449627518845;5125.38495380553;5160.793568257265;4984.953159836438;5049.419316778581;5049.924251136199;5057.974710126426;5077.949220507785;5098.566621837148;5189.221616757479;5245.86885327866;5355.6251062425645;5393.4336894626285;5948.643081415085;5973.581849270553;5991.400859914017;5991.880162396771;5997.490213331872;5875.882482350329;6039.124326972608;6058.1518587397795;6064.332923378425;6078.787242446538;5504.0643090675085;5534.391216966131;5535.25274087997;5581.916271255935;5636.379998200195;6118.663473508911;6141.109539116893;6183.567150299526;6193.102000210034;6206.255249370104;5615.971920140373;5931.940680593225;5932.495737862244;5935.821925342247;5938.584299099021;5876.882462350814;5923.437273459014;5939.613925094855;5967.671778052249;6028.9397106029255;5896.705164741746;5899.852503687443;5903.996320625504;5974.940250597525;6007.549433792396;5710.400407957188;5912;5914.2311499504785;5926.7925622603;5928.3775203603;4513.11994161142;4559.817607295671;4593.885152871138;4625.884352891205;4629.8842528936375;4093.201825643971;4096.774677392712;4100.159467309194;4136.875893723193;4142.751434913915;5415.458454154553;5714.714264286769;5718.513926316226;5718.599698021182;5725.971370143123;5877.706114694248;5896.145058966512;5923.911141332884;5951.642901425928;5971.4924231439945;5634.1830434586755;5755.22304488897;5763;5763.971180144156;5767.163761254678;5113.616478764107;5246.7638956247065;5293.497117773805;5296.761645725952;5300.655457395257;6118.357572454828;6131.816045518642;6206.875862482815;6232.688365581794;6237.688115594202;5985.970070149796;6003.701800511887;6007.038873780174;6011.158437818796;6069.0592958091565;5910.645361278337;5965.373635768182;6190.7214175363115;6230.6884655767935;6239.656818874824;5745.97127014379;5894.587378883437;5964.910526342195;5978.342382338026;6027.095935609694;5973.940260597338;6012.488938440281;6012.909806352821;6020.608660437058;6039.969800150971;5540.168974653673;5700.287464066992;5847.327557330961;5850.765969361178;5855.3559108498885;5708.743106560298;5751.539876809761;5823.883522329615;5829.417058294306;5843.824685259449;5598.524125449219;5672.602917795714;5678.630888992202;5687.857803554944;5691.971540142273;5669.007923613269;5699.401562836008;5713.228714123707;5720.685362305113;5784.595078344475;5458.208559758733;5603.691796951207;5607.523360514402;5663.915041274467;5765.827025189251 05:59:18 INFO - 2015-11-21 05:59:18,309 DEBUG : BROWSER_OUTPUT: |1;ext.html;579.5189992306384;591.8786648737009;598.1595857819764;618.4217756397766;630.5775130662456;32390.67609323906;40787.79606101969;41340.58659413409;41378.37932431016;41402.58597414025;44101.11797764043;44356.556434435646;44614.77692611532;44653.553464465345;44669.88325291861;7600;7779.844403111934;8701.695440659594;8879.378443508956;8892;10134.074525840068;10320.845187322197;10325.483725813718;10338.431386273753;10347.74130646736;10071.446070466121;10143.543540540657;10146.64486742964;10163;10163.542640581154;10063.69808905734;10135.290529662927;10151;10162.288639795217;10163.288569800154;9970.302078854484;10087.092161705481;10097;10356.171506279556;10376.533056012497;40300.19399611992;40608;40637.79681101605;40735.59264407348;40762;3416.6241713411505;3512.420450625669;3753;3857.3828187489867;4144.668426525871;30243.243918901982;30292.091237262917;30959.0712278632;31281.530777038362;31670.366592668248;3905.2324945567275;3910.1006768443417;3975.8210880510446;4034.4150098235887;4093.97953010236;286095;286265;287262;287665;289431;56626;57574.13638795421;59639.701801490715;59711.40288597145;60024.69987650034;63223;63392;64026;64084.35915640784;64098;14243.78634320486;14353.6411589709;14365.712685746226;14406;14411.42354305816;10532.946705329407;10544.314619549705;10547.103496202755;10549.525271362807;10555.313904596176;19463.31878384278;19734;19763.60472790536;19861;19861.702074468896;7225.24134965821;7383.261673832574;7387.298206670358;7424.777256682308;7428.4428667850125;907.5915837872983;1000.8348622477355;1014.9039037839116;1027.3527677563088;1063.6277302943909;25370.365740856258;25505.34900122188;26814.195574132806;26828;26907.86546067296;999.7200783780553;1051.8842927277992;1052.8631277933819;1124.0108704340128;1163.9301641901343;15063.54809355721;15482.30329635169;15599.61000974962;15745.370185192693;15974.92012539953;328838;333615;333775;334072;334213;46640;46926.296105558446;46941.29588056182;46953.5304646956;47028.5297147031;1314.967125821843;1324.0863803975226;1331.3557756171122;1338.1703343927022;1339.36380219395;25499.6175057378;26728.198154055408;28106.859465702542;28289.57565636476;28530.57204141981;43922.560774393125;44270;44311.778441107585;44334.778326108164;44352.778236108614;273959;274136;275897;277730;277833;27849.582256265767;28345;30630;31825.5226171603;32187.195320117185;38522.80738596289;38724.41913371358;38810.223795523365;38995.805020974716;39561.60438395695;32718.34563308768;32890.5066423999;32988.17529561684;33092.503612446315;35047;28428.57357139603;30858.69141308558;32266.83866580652;32935.835320823244;37931.81034094812;33746.83126584352;35004;35070.649293506736;35093.12267193238;35096.824515877255;29211;31512.212194695316;31797.523037154;32389.67610323961;32612;24346.391340215927;24440.75559244456;24669.136580219605;25003.374915627253;25047.373815654755 05:59:18 INFO - 2015-11-21 05:59:18,309 DEBUG : BROWSER_OUTPUT: |2;jquery.html;349.91077275294793;357.36032501821734;358.66823188550586;359.5128600745989;360.9639036096391;13944.302784860742;14239.074460160082;16440.91779541102;16804.91597542012;17537.54474373587;13890.930545347259;14875.256237188152;15150.924245378757;15152.696946061073;15903.204839757995;5274.997750427416;5337.4662533746705;5342.118550439173;5363.54409875161;5364.973175134119;3982.7012974027066;4099.098198396348;5338.199270109495;5371.221172929922;5828.50457711093;5925;5991.131285963533;5993.610415323012;5997.100434934773;5998.40015998401;5801.303843538782;5930.347661757203;5934.495567876757;5934.6142500737315;5976.193213916109;5200.323957885488;5202.947970520284;5224.973875130638;5236.6857988520815;5238.947610523884;19695.212191512466;20487;20709.58580828375;20718.689219661715;20755.066022029045;2092.5396412789164;2183;2202.174184680745;2222.9333120006427;2403.375122468171;13107.410166542528;13178.67053323665;13246.933765331112;13529.32353382327;13592.25242611656;1792.4085051932832;1801.927922883083;1817.781866176054;1828.4971632800953;1859.6373707127116;57118.143227851615;58628.41371586315;59896;60296.39703602951;61177.38822611761;8889.19997200255;9351.345405821527;9440.527973601293;9531.332806703604;9613.567389467491;12064.638060858188;12108.394580270951;12144.089193310538;12148;12205.938970305091;6725.19297684281;6738.427233685192;6742.157230346207;6809.489288303397;6891.931080689229;6749.898751518731;6824;6890.379865812101;6915.89626155598;6969.54697944632;3949.9012524686536;3988.4216788565495;4002.399640053957;4008.318585840414;4018.738781979162;1595.6728870581503;1633.0609899307944;1638.6313079557003;1644.597073716947;1679.2107709376573;929.3587424676952;967.6806653804227;981.7972983095793;982.4350998175935;991.6925753016588;15932.920335398481;16572;16743;17057.232424540925;17104.74342884858;878.5168157513469;879.3229213505565;917.454114801692;946.7491114854569;984.9756253496283;9342.57958391874;9544.52277386128;9557.378770379903;9602.07958408321;9705.757356066155;552447;553221;555246;570647;578012;79567;79661.20338796654;80231;80470.36707430541;81239.5938020306;1061.0291583201438;1065.1744897704186;1066.1524088349781;1073.8926107389354;1075.4138994247996;14888.404463821325;14959.700805984037;15141.848581514043;15167.165805880783;15201.92399038042;35624;35649.643503564635;36178.8191059043;36542.45186322154;36624.81687591545;49333.75333123455;50157.74921125371;50601.74699126481;52755;53036.73481632567;9033.141851524095;9354.485503297385;9355.85966210521;9516.33385662997;9769.364991275828;10933.671989839999;10936.398498082683;10951.890481095406;11037;11675.591354302558;11625.534978600761;13128.868711312765;14131.434742610181;14334.21161836109;14418.13491190532;13640.727185456433;13759.518416855362;13857.168569885838;14214.786778198128;14416.207108609127;14338.283085845875;14390.136591804525;14398.928005359907;14677.92661036688;14768.852311476749;8340.916590834015;8414.074451810418;8755.868661969947;9150.267978561566;9233.676821311223;13799.862001379857;13849.307534623027;14233.857661423668;14253.714925701635;14394.856051439352 05:59:18 INFO - 2015-11-21 05:59:18,310 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1486.4648726458465;1649.4721689059502;1695.1608953567986;1711.7175666015116;1738.9826101738984;6350.682465876705;6994.580325180493;7116.110486189226;7116.395106415948;7127.536710113839;7330.120385553728;7423.220561840996;7426.628668566564;7428.442866784986;7438.293362130603;1749.4751574527654;1786.4729904678086;2213.6236839737285;2222.1111555377856;2246.696695946043;2224.3660556741333;2225.499262665903;2226.198568515333;2228.8996995135176;2229.1306390507634;2162.524244666171;2255.3121298004103;2259.6949411829355;2265.3883451468096;2268.0134141648355;1963.0381113254546;1992.3624440179149;2183.0503730877117;2220.378294077661;2226.220822712054;2193.4954960359046;2217.3347995601257;2224.2659922225625;2247.2359397804826;2249.224017713886;7470.103587569526;7523.661435235427;7526.247375262485;7528.8117797054965;7534.510256833289;4542.8864278392975;4588.541145885385;4605.562471565196;4612.76936153191;4620.8151673933;2978.568107624404;3043.8782448702027;3092.567040614293;3099.628044634636;3102.410541997036;971.771633666088;974.7758015656368;980.6420656460411;986.0977205856633;1025.067188858143;10016;10175.643852465202;10184.694459166238;10188.643397481126;10190.439525826077;3932.174243408859;3976.5029371328583;4039.111395492987;4066.369712694537;4070.592940705965;8202.138775428613;8214.548199848947;8233.588320583947;8237.95881020603;8268.297194738394;4530.29780384041;4550.408446901882;4555.385023021916;4559.658025648089;4560.042391097841;4164.3961625564125;4186.434831297796;4194.0563373240775;4195.286801243796;4201.390798334285;3399.133221028622;3419.9658003420145;3443.380191565492;3448.896533103961;3449.5688038995127;1059.4967390489455;1078.4014871746099;1080.8162612355918;1095.5617752898904;1096.6545538155615;931.9487428191514;999.4003597841382;1021.2851004297022;1182.184292837939;1265.2092442223611;6218.067289906459;7098.787036388917;7261.600611966287;7293.452991025694;7301.59841208728;602.4848754315085;624.1044101714054;625.6934102289845;627.0312367392389;632.6235889645653;5280.20796880471;5502.449755024466;5503.257060296809;5515.227868098469;5554.944450555443;8855.424397414148;8898.510581918057;8984.595693193822;8986.236169925498;8991.055939126429;8857.335699822539;8895.421797583136;8898.4660920345;8902.73291801247;8903.797987271635;6705.463562914955;6837.042814006043;6846.623435710984;6861.965690171617;6904.861902761917;6739.359760822714;6769.086173366532;6770.898436523555;6774.830629234309;6778.084958530535;7730.690772369042;7927.286544211049;8051.194880511902;8071.354291656536;8076.757697269091;8110.513369197867;8118.715844945398;8168.469049511763;8209.671613135408;8210.261076503144;6406.458155210556;6539.659369829269;6584.572002819801;6606.042123892104;6606.108175396452;7342.375898048512;7381.741639042608;7388.519746216479;7406.629668516661;7408.259174082548;6651.800445986628;6726.327367263235;6759.628220447923;6808.421284190701;6914.170299563883;6746.898796518154;6769.864602708017;6845.657717114224;6917.550359226634;6949.826254343682;6711.697973591103;6731.596104233761;6774.661266936732;6816;6821.727130914708;6050.515958723204;6078.3921607838865;6124.5712800103565;6133.570650054453;6136.723847426966;6319.52603554726;6330.936690633035;6346.714397852015;6380.872382552416;6392.169018027626 05:59:18 INFO - 2015-11-21 05:59:18,314 DEBUG : BROWSER_OUTPUT: |4;prototype.html;323.54218780425697;325.29573473430025;331.7826823430654;332.73381294964025;334.34134754533574;5989.82030539084;6013.428724271193;6048.758049678007;6080;6112.144299798032;5749.971250143754;5859.355470898197;5915.467607915287;6013;6047.5766696331275;4650.209464391061;4657.580817726404;4669.392978912753;4675.509071547481;4690.038542098861;4377.1683380157665;4669.509701481346;4673.6027437667835;4673.742944138071;4678.181318269306;4429.1806015887005;4455.153520831048;4536.27419612862;4560.384348112995;4588.518205588415;4583.724976501404;4593.632509399274;4603.539646035403;4604.2964103282;4607.10161518504;4027.556968733437;4028.133951200506;4030.7581545107387;4038.697097717683;4045;5584.21820945068;5727.513161381287;5727.914081288784;5733.684647344436;5743.483086522233;5250.7112108834;5253.9737301313635;5259.631825772198;5262.947370526284;5272.9736351318;6398.29618741938;6398.360163983611;6405.519586031066;6415.326390728999;6419.422251997296;4366.585174408426;4369.6285815705705;4372.344148377737;4377.912441751179;4383.736975781431;6497.93502064978;6552.836179095513;6596.043573681837;6607.6696165192025;6621.370969757865;4483.887902802456;4485.730856148642;4488.371627972087;4499.0776890737325;4503.211937910853;4524;4532.478764942074;4534.523874993079;4547.386102876069;4552.635789136861;5293.867653308621;5297.337832770903;5298.15229563268;5305.734713264322;5313.654612450256;6318.905216421757;6437.613743175424;6472.579282346633;6481.351864813575;6481.611103333815;1598.0890892191571;1620.5786495511015;1621.0678859655745;1621.481126039656;1625.2280166920855;1068.1721665708983;1068.3803394031443;1070.117153348475;1085.451846817368;1088.6733979806027;6178.258608966953;6241.407066328691;6245;6245.250569931637;6255.499560035186;6446.3553644636095;6639.070530125786;6641.900371494431;6650.600963942179;6659.2008958925235;6171.691415429211;6224.906626400608;6264.373562643699;6299.181106456132;6306.306306306303;3566.054995426214;3619.4027985382118;3622.1487950331652;3622.8731994380596;3634.2186429917697;6750.291219421988;6931.965340173267;6937.618430986344;6938.340857618518;6942.583444993316;6844.1444819397575;6849.691763870638;6852.828679282959;6855.245922948472;6863.622500762506;6921.307869213139;6922.376986071277;6924.23833378328;6929.826754331081;6949.2008419031445;6574.4740420765265;6632.137822083098;6683.298253683293;6687.531872768859;6697.564658297195;6629.370209830058;6635.867282654416;6640.369164929324;6651.833704157435;6653.63405012729;6881.587104773729;6914.51598388108;6917.273686263071;6937.93062069393;6948.062011628365;4497.257952437942;4563.908721825611;4573.085382923495;4573.862784116482;4575;6615.4376877965915;6652.4345430637;6668.599884006975;6671.232808226922;6671.733130674718;6429.164208652845;6435.324290949383;6444.9033264502;6448.806535803933;6450.193725784277;6262.780802671885;6423.710933007932;6434.678266086583;6435.452986496013;6437.613743175424;6351.237851457855;6355.713992870239;6367.204099487564;6368.745250189941;6375;6496.058071579689;6497.285298617243;6505.804825855232;6506.934930650633;6510.153680021756;6196.535259855439;6336.841578960563;6337.049442583465;6349.746010159727;6354.872902541831 05:59:18 INFO - 2015-11-21 05:59:18,314 DEBUG : BROWSER_OUTPUT: |5;yui.html;803.7026300268901;811.2009670474582;832.9500229986197;842.9747107586775;863.0592654007133;12955.935220323898;13177.275249861254;13187.93406032971;13188.736225275488;13200.999999999987;13073.542426015092;13612.183269003866;13618.727625447485;13622.386992585332;13638.931805340984;670.7752902777576;683.6479213205204;803.1045384396415;824.3364091906013;826.5082276045744;806.8386322735447;826.243986752121;826.3926014379456;828.3207769628876;833.9082700902895;844.9197326253995;862.4609618988133;865.3034307382586;866.8656358264448;867.6182479708939;696.0325148044222;705.3369832357594;848.3340577646549;859.4370687199894;860.3375400941303;617.4967401567708;621.8414304352361;628.4092952624518;629.4523764325066;631.4821846086211;13011.349432528335;13103.47586096555;13113.934430327883;13142;13183.340832958409;11916.404179790976;11935;12029.699257518545;12098.879011209863;12180.939095304555;10238.385696858139;10395.975751322;10455.634052808191;10515.84226236607;10591.523381447776;3510.613832478425;3511.525943997553;3566.7146628269675;3569.321828852536;3571.017970058229;45313;45339.54660453386;45382.77308613436;45401.31898021532;45428.09143817105;9789.265805064648;10080.546375413123;10163.237757168243;10223.539940702687;10565.788684226272;18206.271749129886;18227.72658410125;18229.27082916695;18265.36071237527;18281.99449030316;7309.488335816548;7632.771016869503;7682.270184332479;7687.5387476751575;7703.3067023968115;4120.443740095108;4265.253580623378;4300.806463709078;4303.354496825501;4326.891827704332;2951.439226546949;2952.763778897683;2972.301509145349;2982.2544363909024;2983.731464168192;528.4952870009132;537.4625374625375;546.6037123085731;547.4334064243488;553.9556835453154;508.57025813187795;606.6875559087074;621.6611946489174;632.2570979099539;634.1692382978313;8186.304164146114;8322.209390108052;8440.366972477088;8549.401541892132;8650.548145215125;582.6300299309969;590.3240789296232;605.3492495567283;671.9664016799238;682.2597481732377;3693.5937046925355;3858.8456461741775;3879.1271963807917;3903.941440878389;3926.1951299983434;56468.717656411456;57188;57261;57408.42591574114;57448;52034.739826300625;52039.21941170885;52044.47955520472;52153.7392313036;53458.46541534612;46024.539754602694;46470.5352946473;47797.52202478;47864.282035769495;48227.276590851165;8960.731178064669;9048;9318.254539636948;9388.530573471162;9561.665341713286;33478.66521334756;33758.83120584382;33760.49359259564;34105.65894341025;34492;43501.3474797872;44630.776846115565;44638.55361446344;44968.32547511855;45855.54144458513;10920.672379828618;11296.83054754163;11302.943485282522;11429.59996400122;11655.30068195911;12301.32342721159;12379.133460658028;12385.442655080724;12389.380530973234;12474.750504989668;11601.12991525622;11702.122340824302;11705.88294117082;11775.352355620524;12174.939125304316;10595.894041059799;10973.780524389627;11091;11363.772724545628;11516.136289778467;11032.28290161137;11302.208845380745;11480.483378247833;11535.307881527135;11869;9755.612954500242;9941.204703623549;10068.899311006797;10123.59505619767;10189.541470633987;8748.343874209588;9066.637334506546;9954.153896918842;10016.499175041365;10020.949895250476 05:59:18 INFO - 2015-11-21 05:59:18,314 DEBUG : BROWSER_OUTPUT: __end_tp_report 05:59:18 INFO - 2015-11-21 05:59:18,314 DEBUG : BROWSER_OUTPUT: __start_cc_report 05:59:18 INFO - 2015-11-21 05:59:18,314 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,996 05:59:18 INFO - 2015-11-21 05:59:18,314 DEBUG : BROWSER_OUTPUT: __end_cc_report 05:59:18 INFO - 2015-11-21 05:59:18,314 DEBUG : BROWSER_OUTPUT: __startTimestamp1448114358305__endTimestamp 05:59:18 INFO - 2015-11-21 05:59:18,314 DEBUG : BROWSER_OUTPUT: 05:59:18 INFO - 2015-11-21 05:59:18,314 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 05:59:18 INFO - 2015-11-21 05:59:18,315 DEBUG : BROWSER_OUTPUT: Number of tests: 6 05:59:18 INFO - 2015-11-21 05:59:18,315 DEBUG : BROWSER_OUTPUT: 05:59:18 INFO - 2015-11-21 05:59:18,315 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:5526.73 Median:5710.40 stddev:614.89 (10.8%) stddev-sans-first:589.89 05:59:18 INFO - 2015-11-21 05:59:18,315 DEBUG : BROWSER_OUTPUT: Values: 3234.1 3283.8 3333.1 3335.6 3345.3 5280.4 5432.9 5496.2 5532.3 5536.0 5452.8 5499.9 5537.9 5554.6 5615.4 5014.3 5031.9 5042.2 5065.2 5092.7 4902.3 5084.8 5148.5 5167.5 5242.6 5006.9 5014.3 5112.1 5142.6 5152.9 5089.1 5098.6 5100.7 5125.4 5160.8 4985.0 5049.4 5049.9 5058.0 5077.9 5098.6 5189.2 5245.9 5355.6 5393.4 5948.6 5973.6 5991.4 5991.9 5997.5 5875.9 6039.1 6058.2 6064.3 6078.8 5504.1 5534.4 5535.3 5581.9 5636.4 6118.7 6141.1 6183.6 6193.1 6206.3 5616.0 5931.9 5932.5 5935.8 5938.6 5876.9 5923.4 5939.6 5967.7 6028.9 5896.7 5899.9 5904.0 5974.9 6007.5 5710.4 5912.0 5914.2 5926.8 5928.4 4513.1 4559.8 4593.9 4625.9 4629.9 4093.2 4096.8 4100.2 4136.9 4142.8 5415.5 5714.7 5718.5 5718.6 5726.0 5877.7 5896.1 5923.9 5951.6 5971.5 5634.2 5755.2 5763.0 5764.0 5767.2 5113.6 5246.8 5293.5 5296.8 5300.7 6118.4 6131.8 6206.9 6232.7 6237.7 5986.0 6003.7 6007.0 6011.2 6069.1 5910.6 5965.4 6190.7 6230.7 6239.7 5746.0 5894.6 5964.9 5978.3 6027.1 5973.9 6012.5 6012.9 6020.6 6040.0 5540.2 5700.3 5847.3 5850.8 5855.4 5708.7 5751.5 5823.9 5829.4 5843.8 5598.5 5672.6 5678.6 5687.9 5692.0 5669.0 5699.4 5713.2 5720.7 5784.6 5458.2 5603.7 5607.5 5663.9 5765.8 05:59:18 INFO - 2015-11-21 05:59:18,315 DEBUG : BROWSER_OUTPUT: 05:59:18 INFO - 2015-11-21 05:59:18,315 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:46480.22 Median:32006.36 stddev:78385.42 (244.9%) stddev-sans-first:78529.55 05:59:18 INFO - 2015-11-21 05:59:18,316 DEBUG : BROWSER_OUTPUT: Values: 579.5 591.9 598.2 618.4 630.6 32390.7 40787.8 41340.6 41378.4 41402.6 44101.1 44356.6 44614.8 44653.6 44669.9 7600.0 7779.8 8701.7 8879.4 8892.0 10134.1 10320.8 10325.5 10338.4 10347.7 10071.4 10143.5 10146.6 10163.0 10163.5 10063.7 10135.3 10151.0 10162.3 10163.3 9970.3 10087.1 10097.0 10356.2 10376.5 40300.2 40608.0 40637.8 40735.6 40762.0 3416.6 3512.4 3753.0 3857.4 4144.7 30243.2 30292.1 30959.1 31281.5 31670.4 3905.2 3910.1 3975.8 4034.4 4094.0 286095.0 286265.0 287262.0 287665.0 289431.0 56626.0 57574.1 59639.7 59711.4 60024.7 63223.0 63392.0 64026.0 64084.4 64098.0 14243.8 14353.6 14365.7 14406.0 14411.4 10532.9 10544.3 10547.1 10549.5 10555.3 19463.3 19734.0 19763.6 19861.0 19861.7 7225.2 7383.3 7387.3 7424.8 7428.4 907.6 1000.8 1014.9 1027.4 1063.6 25370.4 25505.3 26814.2 26828.0 26907.9 999.7 1051.9 1052.9 1124.0 1163.9 15063.5 15482.3 15599.6 15745.4 15974.9 328838.0 333615.0 333775.0 334072.0 334213.0 46640.0 46926.3 46941.3 46953.5 47028.5 1315.0 1324.1 1331.4 1338.2 1339.4 25499.6 26728.2 28106.9 28289.6 28530.6 43922.6 44270.0 44311.8 44334.8 44352.8 273959.0 274136.0 275897.0 277730.0 277833.0 27849.6 28345.0 30630.0 31825.5 32187.2 38522.8 38724.4 38810.2 38995.8 39561.6 32718.3 32890.5 32988.2 33092.5 35047.0 28428.6 30858.7 32266.8 32935.8 37931.8 33746.8 35004.0 35070.6 35093.1 35096.8 29211.0 31512.2 31797.5 32389.7 32612.0 24346.4 24440.8 24669.1 25003.4 25047.4 05:59:18 INFO - 2015-11-21 05:59:18,316 DEBUG : BROWSER_OUTPUT: 05:59:18 INFO - 2015-11-21 05:59:18,316 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:29325.16 Median:3966.30 stddev:91854.61 (2315.9%) stddev-sans-first:92086.52 05:59:18 INFO - 2015-11-21 05:59:18,316 DEBUG : BROWSER_OUTPUT: Values: 349.9 357.4 358.7 359.5 361.0 13944.3 14239.1 16440.9 16804.9 17537.5 13890.9 14875.3 15150.9 15152.7 15903.2 5275.0 5337.5 5342.1 5363.5 5365.0 3982.7 4099.1 5338.2 5371.2 5828.5 5925.0 5991.1 5993.6 5997.1 5998.4 5801.3 5930.3 5934.5 5934.6 5976.2 5200.3 5202.9 5225.0 5236.7 5238.9 19695.2 20487.0 20709.6 20718.7 20755.1 2092.5 2183.0 2202.2 2222.9 2403.4 13107.4 13178.7 13246.9 13529.3 13592.3 1792.4 1801.9 1817.8 1828.5 1859.6 57118.1 58628.4 59896.0 60296.4 61177.4 8889.2 9351.3 9440.5 9531.3 9613.6 12064.6 12108.4 12144.1 12148.0 12205.9 6725.2 6738.4 6742.2 6809.5 6891.9 6749.9 6824.0 6890.4 6915.9 6969.5 3949.9 3988.4 4002.4 4008.3 4018.7 1595.7 1633.1 1638.6 1644.6 1679.2 929.4 967.7 981.8 982.4 991.7 15932.9 16572.0 16743.0 17057.2 17104.7 878.5 879.3 917.5 946.7 985.0 9342.6 9544.5 9557.4 9602.1 9705.8 552447.0 553221.0 555246.0 570647.0 578012.0 79567.0 79661.2 80231.0 80470.4 81239.6 1061.0 1065.2 1066.2 1073.9 1075.4 14888.4 14959.7 15141.8 15167.2 15201.9 35624.0 35649.6 36178.8 36542.5 36624.8 49333.8 50157.7 50601.7 52755.0 53036.7 9033.1 9354.5 9355.9 9516.3 9769.4 10933.7 10936.4 10951.9 11037.0 11675.6 11625.5 13128.9 14131.4 14334.2 14418.1 13640.7 13759.5 13857.2 14214.8 14416.2 14338.3 14390.1 14398.9 14677.9 14768.9 8340.9 8414.1 8755.9 9150.3 9233.7 13799.9 13849.3 14233.9 14253.7 14394.9 05:59:18 INFO - 2015-11-21 05:59:18,317 DEBUG : BROWSER_OUTPUT: 05:59:18 INFO - 2015-11-21 05:59:18,317 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5200.99 Median:3481.78 stddev:2686.85 (77.2%) stddev-sans-first:2679.88 05:59:18 INFO - 2015-11-21 05:59:18,318 DEBUG : BROWSER_OUTPUT: Values: 1486.5 1649.5 1695.2 1711.7 1739.0 6350.7 6994.6 7116.1 7116.4 7127.5 7330.1 7423.2 7426.6 7428.4 7438.3 1749.5 1786.5 2213.6 2222.1 2246.7 2224.4 2225.5 2226.2 2228.9 2229.1 2162.5 2255.3 2259.7 2265.4 2268.0 1963.0 1992.4 2183.1 2220.4 2226.2 2193.5 2217.3 2224.3 2247.2 2249.2 7470.1 7523.7 7526.2 7528.8 7534.5 4542.9 4588.5 4605.6 4612.8 4620.8 2978.6 3043.9 3092.6 3099.6 3102.4 971.8 974.8 980.6 986.1 1025.1 10016.0 10175.6 10184.7 10188.6 10190.4 3932.2 3976.5 4039.1 4066.4 4070.6 8202.1 8214.5 8233.6 8238.0 8268.3 4530.3 4550.4 4555.4 4559.7 4560.0 4164.4 4186.4 4194.1 4195.3 4201.4 3399.1 3420.0 3443.4 3448.9 3449.6 1059.5 1078.4 1080.8 1095.6 1096.7 931.9 999.4 1021.3 1182.2 1265.2 6218.1 7098.8 7261.6 7293.5 7301.6 602.5 624.1 625.7 627.0 632.6 5280.2 5502.4 5503.3 5515.2 5554.9 8855.4 8898.5 8984.6 8986.2 8991.1 8857.3 8895.4 8898.5 8902.7 8903.8 6705.5 6837.0 6846.6 6862.0 6904.9 6739.4 6769.1 6770.9 6774.8 6778.1 7730.7 7927.3 8051.2 8071.4 8076.8 8110.5 8118.7 8168.5 8209.7 8210.3 6406.5 6539.7 6584.6 6606.0 6606.1 7342.4 7381.7 7388.5 7406.6 7408.3 6651.8 6726.3 6759.6 6808.4 6914.2 6746.9 6769.9 6845.7 6917.6 6949.8 6711.7 6731.6 6774.7 6816.0 6821.7 6050.5 6078.4 6124.6 6133.6 6136.7 6319.5 6330.9 6346.7 6380.9 6392.2 05:59:18 INFO - 2015-11-21 05:59:18,318 DEBUG : BROWSER_OUTPUT: 05:59:18 INFO - 2015-11-21 05:59:18,318 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:5370.83 Median:6174.98 stddev:1634.64 (26.5%) stddev-sans-first:1594.73 05:59:18 INFO - 2015-11-21 05:59:18,318 DEBUG : BROWSER_OUTPUT: Values: 323.5 325.3 331.8 332.7 334.3 5989.8 6013.4 6048.8 6080.0 6112.1 5750.0 5859.4 5915.5 6013.0 6047.6 4650.2 4657.6 4669.4 4675.5 4690.0 4377.2 4669.5 4673.6 4673.7 4678.2 4429.2 4455.2 4536.3 4560.4 4588.5 4583.7 4593.6 4603.5 4604.3 4607.1 4027.6 4028.1 4030.8 4038.7 4045.0 5584.2 5727.5 5727.9 5733.7 5743.5 5250.7 5254.0 5259.6 5262.9 5273.0 6398.3 6398.4 6405.5 6415.3 6419.4 4366.6 4369.6 4372.3 4377.9 4383.7 6497.9 6552.8 6596.0 6607.7 6621.4 4483.9 4485.7 4488.4 4499.1 4503.2 4524.0 4532.5 4534.5 4547.4 4552.6 5293.9 5297.3 5298.2 5305.7 5313.7 6318.9 6437.6 6472.6 6481.4 6481.6 1598.1 1620.6 1621.1 1621.5 1625.2 1068.2 1068.4 1070.1 1085.5 1088.7 6178.3 6241.4 6245.0 6245.3 6255.5 6446.4 6639.1 6641.9 6650.6 6659.2 6171.7 6224.9 6264.4 6299.2 6306.3 3566.1 3619.4 3622.1 3622.9 3634.2 6750.3 6932.0 6937.6 6938.3 6942.6 6844.1 6849.7 6852.8 6855.2 6863.6 6921.3 6922.4 6924.2 6929.8 6949.2 6574.5 6632.1 6683.3 6687.5 6697.6 6629.4 6635.9 6640.4 6651.8 6653.6 6881.6 6914.5 6917.3 6937.9 6948.1 4497.3 4563.9 4573.1 4573.9 4575.0 6615.4 6652.4 6668.6 6671.2 6671.7 6429.2 6435.3 6444.9 6448.8 6450.2 6262.8 6423.7 6434.7 6435.5 6437.6 6351.2 6355.7 6367.2 6368.7 6375.0 6496.1 6497.3 6505.8 6506.9 6510.2 6196.5 6336.8 6337.0 6349.7 6354.9 05:59:18 INFO - 2015-11-21 05:59:18,318 DEBUG : BROWSER_OUTPUT: 05:59:18 INFO - 2015-11-21 05:59:18,318 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:13762.43 Median:44634.67 stddev:15848.93 (35.5%) stddev-sans-first:15863.51 05:59:18 INFO - 2015-11-21 05:59:18,319 DEBUG : BROWSER_OUTPUT: Values: 803.7 811.2 833.0 843.0 863.1 12955.9 13177.3 13187.9 13188.7 13201.0 13073.5 13612.2 13618.7 13622.4 13638.9 670.8 683.6 803.1 824.3 826.5 806.8 826.2 826.4 828.3 833.9 844.9 862.5 865.3 866.9 867.6 696.0 705.3 848.3 859.4 860.3 617.5 621.8 628.4 629.5 631.5 13011.3 13103.5 13113.9 13142.0 13183.3 11916.4 11935.0 12029.7 12098.9 12180.9 10238.4 10396.0 10455.6 10515.8 10591.5 3510.6 3511.5 3566.7 3569.3 3571.0 45313.0 45339.5 45382.8 45401.3 45428.1 9789.3 10080.5 10163.2 10223.5 10565.8 18206.3 18227.7 18229.3 18265.4 18282.0 7309.5 7632.8 7682.3 7687.5 7703.3 4120.4 4265.3 4300.8 4303.4 4326.9 2951.4 2952.8 2972.3 2982.3 2983.7 528.5 537.5 546.6 547.4 554.0 508.6 606.7 621.7 632.3 634.2 8186.3 8322.2 8440.4 8549.4 8650.5 582.6 590.3 605.3 672.0 682.3 3693.6 3858.8 3879.1 3903.9 3926.2 56468.7 57188.0 57261.0 57408.4 57448.0 52034.7 52039.2 52044.5 52153.7 53458.5 46024.5 46470.5 47797.5 47864.3 48227.3 8960.7 9048.0 9318.3 9388.5 9561.7 33478.7 33758.8 33760.5 34105.7 34492.0 43501.3 44630.8 44638.6 44968.3 45855.5 10920.7 11296.8 11302.9 11429.6 11655.3 12301.3 12379.1 12385.4 12389.4 12474.8 11601.1 11702.1 11705.9 11775.4 12174.9 10595.9 10973.8 11091.0 11363.8 11516.1 11032.3 11302.2 11480.5 11535.3 11869.0 9755.6 9941.2 10068.9 10123.6 10189.5 8748.3 9066.6 9954.2 10016.5 10020.9 05:59:18 INFO - 2015-11-21 05:59:18,319 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 05:59:18 INFO - 2015-11-21 05:59:18,320 DEBUG : BROWSER_OUTPUT: 05:59:18 INFO - 2015-11-21 05:59:18,962 INFO : Browser exited with error code: 0 05:59:18 INFO - 2015-11-21 05:59:18,980 INFO : Completed test dromaeo_css (00:18:34) 05:59:18 INFO - 2015-11-21 05:59:18,980 INFO : Starting test kraken 05:59:18 INFO - 2015-11-21 05:59:18,980 DEBUG : operating with platform_type : linux_ 05:59:18 INFO - 2015-11-21 05:59:18,980 INFO : Initialising browser for kraken test... 05:59:18 INFO - 2015-11-21 05:59:18,986 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpKyD3hJ/profile http://localhost:38986/getInfo.html 05:59:22 INFO - 2015-11-21 05:59:22,856 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 05:59:22 INFO - 2015-11-21 05:59:22,856 DEBUG : BROWSER_OUTPUT: colorDepth:24 05:59:22 INFO - 2015-11-21 05:59:22,856 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 05:59:22 INFO - 2015-11-21 05:59:22,856 DEBUG : BROWSER_OUTPUT: __metrics 05:59:23 INFO - 2015-11-21 05:59:23,038 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:59:24 INFO - 2015-11-21 05:59:24,255 INFO : Browser initialized. 05:59:24 INFO - 2015-11-21 05:59:24,256 INFO : Running cycle 1/1 for kraken test... 05:59:24 INFO - 2015-11-21 05:59:24,256 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpKyD3hJ/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 05:59:35 INFO - 2015-11-21 05:59:35,987 DEBUG : BROWSER_OUTPUT: RSS: Main: 141762560 05:59:35 INFO - 2015-11-21 05:59:35,987 DEBUG : BROWSER_OUTPUT: 05:59:38 INFO - 2015-11-21 05:59:38,441 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:38986/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:38986/tests/kraken/driver.html?testName=audio-beat-detection) 05:59:39 INFO - 2015-11-21 05:59:39,030 DEBUG : BROWSER_OUTPUT: RSS: Main: 179109888 05:59:39 INFO - 2015-11-21 05:59:39,030 DEBUG : BROWSER_OUTPUT: 05:59:41 INFO - 2015-11-21 05:59:41,613 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:38986/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:38986/tests/kraken/driver.html?testName=audio-dft) 05:59:42 INFO - 2015-11-21 05:59:42,180 DEBUG : BROWSER_OUTPUT: RSS: Main: 166998016 05:59:42 INFO - 2015-11-21 05:59:42,180 DEBUG : BROWSER_OUTPUT: 05:59:45 INFO - 2015-11-21 05:59:45,009 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:38986/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:38986/tests/kraken/driver.html?testName=audio-fft) 05:59:45 INFO - 2015-11-21 05:59:45,570 DEBUG : BROWSER_OUTPUT: RSS: Main: 149778432 05:59:45 INFO - 2015-11-21 05:59:45,570 DEBUG : BROWSER_OUTPUT: 05:59:47 INFO - 2015-11-21 05:59:47,521 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:38986/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:38986/tests/kraken/driver.html?testName=audio-oscillator) 05:59:48 INFO - 2015-11-21 05:59:48,087 DEBUG : BROWSER_OUTPUT: RSS: Main: 155111424 05:59:48 INFO - 2015-11-21 05:59:48,088 DEBUG : BROWSER_OUTPUT: 05:59:50 INFO - 2015-11-21 05:59:50,266 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:38986/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:38986/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:59:50 INFO - 2015-11-21 05:59:50,826 DEBUG : BROWSER_OUTPUT: RSS: Main: 156573696 05:59:50 INFO - 2015-11-21 05:59:50,827 DEBUG : BROWSER_OUTPUT: 05:59:53 INFO - 2015-11-21 05:59:53,766 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:38986/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:38986/tests/kraken/driver.html?testName=imaging-darkroom) 05:59:54 INFO - 2015-11-21 05:59:54,335 DEBUG : BROWSER_OUTPUT: RSS: Main: 155897856 05:59:54 INFO - 2015-11-21 05:59:54,335 DEBUG : BROWSER_OUTPUT: 05:59:57 INFO - 2015-11-21 05:59:57,677 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:38986/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:38986/tests/kraken/driver.html?testName=imaging-desaturate) 05:59:58 INFO - 2015-11-21 05:59:58,244 DEBUG : BROWSER_OUTPUT: RSS: Main: 155504640 05:59:58 INFO - 2015-11-21 05:59:58,244 DEBUG : BROWSER_OUTPUT: 06:00:00 INFO - 2015-11-21 06:00:00,996 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:38986/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:38986/tests/kraken/driver.html?testName=json-parse-financial) 06:00:01 INFO - 2015-11-21 06:00:01,571 DEBUG : BROWSER_OUTPUT: RSS: Main: 156606464 06:00:01 INFO - 2015-11-21 06:00:01,571 DEBUG : BROWSER_OUTPUT: 06:00:03 INFO - 2015-11-21 06:00:03,139 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:38986/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:38986/tests/kraken/driver.html?testName=json-stringify-tinderbox) 06:00:03 INFO - 2015-11-21 06:00:03,705 DEBUG : BROWSER_OUTPUT: RSS: Main: 165285888 06:00:03 INFO - 2015-11-21 06:00:03,706 DEBUG : BROWSER_OUTPUT: 06:00:05 INFO - 2015-11-21 06:00:05,501 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:38986/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:38986/tests/kraken/driver.html?testName=stanford-crypto-aes) 06:00:06 INFO - 2015-11-21 06:00:06,094 DEBUG : BROWSER_OUTPUT: RSS: Main: 165089280 06:00:06 INFO - 2015-11-21 06:00:06,095 DEBUG : BROWSER_OUTPUT: 06:00:08 INFO - 2015-11-21 06:00:08,146 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:38986/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:38986/tests/kraken/driver.html?testName=stanford-crypto-ccm) 06:00:08 INFO - 2015-11-21 06:00:08,720 DEBUG : BROWSER_OUTPUT: RSS: Main: 167907328 06:00:08 INFO - 2015-11-21 06:00:08,720 DEBUG : BROWSER_OUTPUT: 06:00:11 INFO - 2015-11-21 06:00:11,114 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:38986/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:38986/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 06:00:11 INFO - 2015-11-21 06:00:11,700 DEBUG : BROWSER_OUTPUT: RSS: Main: 179695616 06:00:11 INFO - 2015-11-21 06:00:11,701 DEBUG : BROWSER_OUTPUT: 06:00:14 INFO - 2015-11-21 06:00:14,268 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:38986/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:38986/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 06:00:14 INFO - 2015-11-21 06:00:14,841 DEBUG : BROWSER_OUTPUT: RSS: Main: 178872320 06:00:14 INFO - 2015-11-21 06:00:14,841 DEBUG : BROWSER_OUTPUT: 06:00:16 INFO - 2015-11-21 06:00:16,516 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:38986/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:38986/tests/kraken/driver.html?testName=ai-astar) 06:00:16 INFO - 2015-11-21 06:00:16,774 DEBUG : BROWSER_OUTPUT: RSS: Main: 239169536 06:00:16 INFO - 2015-11-21 06:00:16,774 DEBUG : BROWSER_OUTPUT: 06:00:16 INFO - 2015-11-21 06:00:16,774 DEBUG : BROWSER_OUTPUT: __start_tp_report 06:00:16 INFO - 2015-11-21 06:00:16,774 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 06:00:16 INFO - 2015-11-21 06:00:16,774 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 06:00:16 INFO - 2015-11-21 06:00:16,774 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 06:00:16 INFO - 2015-11-21 06:00:16,774 DEBUG : BROWSER_OUTPUT: |0;ai-astar;111;111;104;111;111;111;100;111;109;111 06:00:16 INFO - 2015-11-21 06:00:16,775 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;149;123;151;172;133;164;149;126;169;125 06:00:16 INFO - 2015-11-21 06:00:16,775 DEBUG : BROWSER_OUTPUT: |2;audio-dft;161;160;161;160;158;160;160;163;160;160 06:00:16 INFO - 2015-11-21 06:00:16,775 DEBUG : BROWSER_OUTPUT: |3;audio-fft;72;71;81;90;72;72;72;98;91;72 06:00:16 INFO - 2015-11-21 06:00:16,775 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;90;90;137;90;90;91;140;90;90;135 06:00:16 INFO - 2015-11-21 06:00:16,775 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;109;109;109;109;110;108;109;109;110;110 06:00:16 INFO - 2015-11-21 06:00:16,775 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;146;145;145;145;147;145;145;145;146;145 06:00:16 INFO - 2015-11-21 06:00:16,775 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;96;96;95;96;96;96;96;96;95;96 06:00:16 INFO - 2015-11-21 06:00:16,776 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;61;59;59;63;62;61;61;68;58;57 06:00:16 INFO - 2015-11-21 06:00:16,776 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;69;69;68;69;69;69;70;69;69;70 06:00:16 INFO - 2015-11-21 06:00:16,776 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;84;85;85;86;85;87;87;86;86;86 06:00:16 INFO - 2015-11-21 06:00:16,776 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;117;116;113;113;117;122;126;124;117;122 06:00:16 INFO - 2015-11-21 06:00:16,776 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;150;145;153;152;144;140;152;151;144;145 06:00:16 INFO - 2015-11-21 06:00:16,777 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;68;67;68;68;66;67;68;69;68;73 06:00:16 INFO - 2015-11-21 06:00:16,777 DEBUG : BROWSER_OUTPUT: __end_tp_report 06:00:16 INFO - 2015-11-21 06:00:16,777 DEBUG : BROWSER_OUTPUT: __start_cc_report 06:00:16 INFO - 2015-11-21 06:00:16,777 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,923 06:00:16 INFO - 2015-11-21 06:00:16,777 DEBUG : BROWSER_OUTPUT: __end_cc_report 06:00:16 INFO - 2015-11-21 06:00:16,777 DEBUG : BROWSER_OUTPUT: __startTimestamp1448114416768__endTimestamp 06:00:16 INFO - 2015-11-21 06:00:16,778 DEBUG : BROWSER_OUTPUT: 06:00:16 INFO - 2015-11-21 06:00:16,778 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 06:00:16 INFO - 2015-11-21 06:00:16,778 DEBUG : BROWSER_OUTPUT: Number of tests: 14 06:00:16 INFO - 2015-11-21 06:00:16,778 DEBUG : BROWSER_OUTPUT: 06:00:16 INFO - 2015-11-21 06:00:16,778 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:109.00 Median:111.00 stddev:3.86 (3.5%) stddev-sans-first:4.02 06:00:16 INFO - 2015-11-21 06:00:16,778 DEBUG : BROWSER_OUTPUT: Values: 111.0 111.0 104.0 111.0 111.0 111.0 100.0 111.0 109.0 111.0 06:00:16 INFO - 2015-11-21 06:00:16,778 DEBUG : BROWSER_OUTPUT: 06:00:16 INFO - 2015-11-21 06:00:16,778 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:146.10 Median:150.00 stddev:18.59 (12.4%) stddev-sans-first:19.69 06:00:16 INFO - 2015-11-21 06:00:16,778 DEBUG : BROWSER_OUTPUT: Values: 149.0 123.0 151.0 172.0 133.0 164.0 149.0 126.0 169.0 125.0 06:00:16 INFO - 2015-11-21 06:00:16,778 DEBUG : BROWSER_OUTPUT: 06:00:16 INFO - 2015-11-21 06:00:16,778 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:160.30 Median:160.00 stddev:1.25 (0.8%) stddev-sans-first:1.30 06:00:16 INFO - 2015-11-21 06:00:16,778 DEBUG : BROWSER_OUTPUT: Values: 161.0 160.0 161.0 160.0 158.0 160.0 160.0 163.0 160.0 160.0 06:00:16 INFO - 2015-11-21 06:00:16,779 DEBUG : BROWSER_OUTPUT: 06:00:16 INFO - 2015-11-21 06:00:16,780 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:79.10 Median:76.50 stddev:10.21 (13.4%) stddev-sans-first:10.51 06:00:16 INFO - 2015-11-21 06:00:16,780 DEBUG : BROWSER_OUTPUT: Values: 72.0 71.0 81.0 90.0 72.0 72.0 72.0 98.0 91.0 72.0 06:00:16 INFO - 2015-11-21 06:00:16,780 DEBUG : BROWSER_OUTPUT: 06:00:16 INFO - 2015-11-21 06:00:16,780 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:104.30 Median:90.00 stddev:22.83 (25.4%) stddev-sans-first:23.62 06:00:16 INFO - 2015-11-21 06:00:16,780 DEBUG : BROWSER_OUTPUT: Values: 90.0 90.0 137.0 90.0 90.0 91.0 140.0 90.0 90.0 135.0 06:00:16 INFO - 2015-11-21 06:00:16,780 DEBUG : BROWSER_OUTPUT: 06:00:16 INFO - 2015-11-21 06:00:16,780 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:109.20 Median:109.00 stddev:0.63 (0.6%) stddev-sans-first:0.67 06:00:16 INFO - 2015-11-21 06:00:16,780 DEBUG : BROWSER_OUTPUT: Values: 109.0 109.0 109.0 109.0 110.0 108.0 109.0 109.0 110.0 110.0 06:00:16 INFO - 2015-11-21 06:00:16,780 DEBUG : BROWSER_OUTPUT: 06:00:16 INFO - 2015-11-21 06:00:16,780 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:145.40 Median:145.00 stddev:0.70 (0.5%) stddev-sans-first:0.71 06:00:16 INFO - 2015-11-21 06:00:16,780 DEBUG : BROWSER_OUTPUT: Values: 146.0 145.0 145.0 145.0 147.0 145.0 145.0 145.0 146.0 145.0 06:00:16 INFO - 2015-11-21 06:00:16,780 DEBUG : BROWSER_OUTPUT: 06:00:16 INFO - 2015-11-21 06:00:16,781 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:95.80 Median:96.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 06:00:16 INFO - 2015-11-21 06:00:16,781 DEBUG : BROWSER_OUTPUT: Values: 96.0 96.0 95.0 96.0 96.0 96.0 96.0 96.0 95.0 96.0 06:00:16 INFO - 2015-11-21 06:00:16,781 DEBUG : BROWSER_OUTPUT: 06:00:16 INFO - 2015-11-21 06:00:16,781 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:60.90 Median:61.00 stddev:3.11 (5.1%) stddev-sans-first:3.30 06:00:16 INFO - 2015-11-21 06:00:16,781 DEBUG : BROWSER_OUTPUT: Values: 61.0 59.0 59.0 63.0 62.0 61.0 61.0 68.0 58.0 57.0 06:00:16 INFO - 2015-11-21 06:00:16,781 DEBUG : BROWSER_OUTPUT: 06:00:16 INFO - 2015-11-21 06:00:16,781 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:69.10 Median:69.00 stddev:0.57 (0.8%) stddev-sans-first:0.60 06:00:16 INFO - 2015-11-21 06:00:16,781 DEBUG : BROWSER_OUTPUT: Values: 69.0 69.0 68.0 69.0 69.0 69.0 70.0 69.0 69.0 70.0 06:00:16 INFO - 2015-11-21 06:00:16,781 DEBUG : BROWSER_OUTPUT: 06:00:16 INFO - 2015-11-21 06:00:16,781 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:85.70 Median:86.00 stddev:0.95 (1.1%) stddev-sans-first:0.78 06:00:16 INFO - 2015-11-21 06:00:16,781 DEBUG : BROWSER_OUTPUT: Values: 84.0 85.0 85.0 86.0 85.0 87.0 87.0 86.0 86.0 86.0 06:00:16 INFO - 2015-11-21 06:00:16,782 DEBUG : BROWSER_OUTPUT: 06:00:16 INFO - 2015-11-21 06:00:16,782 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:118.70 Median:119.50 stddev:4.52 (3.8%) stddev-sans-first:4.76 06:00:16 INFO - 2015-11-21 06:00:16,782 DEBUG : BROWSER_OUTPUT: Values: 117.0 116.0 113.0 113.0 117.0 122.0 126.0 124.0 117.0 122.0 06:00:16 INFO - 2015-11-21 06:00:16,782 DEBUG : BROWSER_OUTPUT: 06:00:16 INFO - 2015-11-21 06:00:16,782 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:147.60 Median:150.50 stddev:4.50 (3.0%) stddev-sans-first:4.69 06:00:16 INFO - 2015-11-21 06:00:16,782 DEBUG : BROWSER_OUTPUT: Values: 150.0 145.0 153.0 152.0 144.0 140.0 152.0 151.0 144.0 145.0 06:00:16 INFO - 2015-11-21 06:00:16,782 DEBUG : BROWSER_OUTPUT: 06:00:16 INFO - 2015-11-21 06:00:16,782 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.20 Median:68.00 stddev:1.87 (2.8%) stddev-sans-first:1.99 06:00:16 INFO - 2015-11-21 06:00:16,782 DEBUG : BROWSER_OUTPUT: Values: 68.0 67.0 68.0 68.0 66.0 67.0 68.0 69.0 68.0 73.0 06:00:16 INFO - 2015-11-21 06:00:16,782 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 06:00:16 INFO - 2015-11-21 06:00:16,782 DEBUG : BROWSER_OUTPUT: 06:00:17 INFO - 2015-11-21 06:00:17,654 INFO : Browser exited with error code: 0 06:00:17 INFO - 2015-11-21 06:00:17,704 INFO : Completed test kraken (00:00:58) 06:00:17 INFO - 2015-11-21 06:00:17,704 INFO : Starting test v8_7 06:00:17 INFO - 2015-11-21 06:00:17,704 DEBUG : operating with platform_type : linux_ 06:00:17 INFO - 2015-11-21 06:00:17,705 INFO : Initialising browser for v8_7 test... 06:00:17 INFO - 2015-11-21 06:00:17,711 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpfFXm5y/profile http://localhost:38986/getInfo.html 06:00:21 INFO - 2015-11-21 06:00:21,451 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 06:00:21 INFO - 2015-11-21 06:00:21,451 DEBUG : BROWSER_OUTPUT: colorDepth:24 06:00:21 INFO - 2015-11-21 06:00:21,451 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 06:00:21 INFO - 2015-11-21 06:00:21,451 DEBUG : BROWSER_OUTPUT: __metrics 06:00:21 INFO - 2015-11-21 06:00:21,592 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 06:00:22 INFO - 2015-11-21 06:00:22,779 INFO : Browser initialized. 06:00:22 INFO - 2015-11-21 06:00:22,780 INFO : Running cycle 1/1 for v8_7 test... 06:00:22 INFO - 2015-11-21 06:00:22,780 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpfFXm5y/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 06:00:34 INFO - 2015-11-21 06:00:34,552 DEBUG : BROWSER_OUTPUT: RSS: Main: 142336000 06:00:34 INFO - 2015-11-21 06:00:34,553 DEBUG : BROWSER_OUTPUT: 06:00:55 INFO - 2015-11-21 06:00:55,986 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:38986/tests/v8_7/run.html (next: http://localhost:38986/tests/v8_7/run.html) 06:00:56 INFO - 2015-11-21 06:00:56,230 DEBUG : BROWSER_OUTPUT: RSS: Main: 567418880 06:00:56 INFO - 2015-11-21 06:00:56,230 DEBUG : BROWSER_OUTPUT: 06:00:56 INFO - 2015-11-21 06:00:56,232 DEBUG : BROWSER_OUTPUT: __start_tp_report 06:00:56 INFO - 2015-11-21 06:00:56,232 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 06:00:56 INFO - 2015-11-21 06:00:56,232 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 06:00:56 INFO - 2015-11-21 06:00:56,232 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 06:00:56 INFO - 2015-11-21 06:00:56,232 DEBUG : BROWSER_OUTPUT: |0;Richards;162.89297931259162 06:00:56 INFO - 2015-11-21 06:00:56,232 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;194.96977968414896 06:00:56 INFO - 2015-11-21 06:00:56,233 DEBUG : BROWSER_OUTPUT: |2;Encrypt;285.38812785388126 06:00:56 INFO - 2015-11-21 06:00:56,233 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5030.150753768844 06:00:56 INFO - 2015-11-21 06:00:56,233 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1970.4724409448818 06:00:56 INFO - 2015-11-21 06:00:56,233 DEBUG : BROWSER_OUTPUT: |5;Earley;758.7253414264036 06:00:56 INFO - 2015-11-21 06:00:56,233 DEBUG : BROWSER_OUTPUT: |6;Boyer;12192.77108433735 06:00:56 INFO - 2015-11-21 06:00:56,233 DEBUG : BROWSER_OUTPUT: |7;RegExp;25550 06:00:56 INFO - 2015-11-21 06:00:56,233 DEBUG : BROWSER_OUTPUT: |8;Splay;610.9422492401216 06:00:56 INFO - 2015-11-21 06:00:56,234 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4830.917874396136 06:00:56 INFO - 2015-11-21 06:00:56,234 DEBUG : BROWSER_OUTPUT: __end_tp_report 06:00:56 INFO - 2015-11-21 06:00:56,234 DEBUG : BROWSER_OUTPUT: __startTimestamp1448114456231__endTimestamp 06:00:56 INFO - 2015-11-21 06:00:56,234 DEBUG : BROWSER_OUTPUT: 06:00:56 INFO - 2015-11-21 06:00:56,234 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 06:00:56 INFO - 2015-11-21 06:00:56,235 DEBUG : BROWSER_OUTPUT: Number of tests: 10 06:00:56 INFO - 2015-11-21 06:00:56,236 DEBUG : BROWSER_OUTPUT: 06:00:56 INFO - 2015-11-21 06:00:56,236 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:162.89 Median:162.89 stddev:0.00 (0.0%) 06:00:56 INFO - 2015-11-21 06:00:56,236 DEBUG : BROWSER_OUTPUT: Values: 162.9 06:00:56 INFO - 2015-11-21 06:00:56,236 DEBUG : BROWSER_OUTPUT: 06:00:56 INFO - 2015-11-21 06:00:56,236 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:194.97 Median:194.97 stddev:0.00 (0.0%) 06:00:56 INFO - 2015-11-21 06:00:56,236 DEBUG : BROWSER_OUTPUT: Values: 195.0 06:00:56 INFO - 2015-11-21 06:00:56,236 DEBUG : BROWSER_OUTPUT: 06:00:56 INFO - 2015-11-21 06:00:56,236 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:285.39 Median:285.39 stddev:0.00 (0.0%) 06:00:56 INFO - 2015-11-21 06:00:56,236 DEBUG : BROWSER_OUTPUT: Values: 285.4 06:00:56 INFO - 2015-11-21 06:00:56,236 DEBUG : BROWSER_OUTPUT: 06:00:56 INFO - 2015-11-21 06:00:56,236 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5030.15 Median:5030.15 stddev:0.00 (0.0%) 06:00:56 INFO - 2015-11-21 06:00:56,236 DEBUG : BROWSER_OUTPUT: Values: 5030.2 06:00:56 INFO - 2015-11-21 06:00:56,236 DEBUG : BROWSER_OUTPUT: 06:00:56 INFO - 2015-11-21 06:00:56,236 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1970.47 Median:1970.47 stddev:0.00 (0.0%) 06:00:56 INFO - 2015-11-21 06:00:56,236 DEBUG : BROWSER_OUTPUT: Values: 1970.5 06:00:56 INFO - 2015-11-21 06:00:56,237 DEBUG : BROWSER_OUTPUT: 06:00:56 INFO - 2015-11-21 06:00:56,237 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:758.73 Median:758.73 stddev:0.00 (0.0%) 06:00:56 INFO - 2015-11-21 06:00:56,237 DEBUG : BROWSER_OUTPUT: Values: 758.7 06:00:56 INFO - 2015-11-21 06:00:56,237 DEBUG : BROWSER_OUTPUT: 06:00:56 INFO - 2015-11-21 06:00:56,237 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:12192.77 Median:12192.77 stddev:0.00 (0.0%) 06:00:56 INFO - 2015-11-21 06:00:56,237 DEBUG : BROWSER_OUTPUT: Values: 12192.8 06:00:56 INFO - 2015-11-21 06:00:56,237 DEBUG : BROWSER_OUTPUT: 06:00:56 INFO - 2015-11-21 06:00:56,237 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:25550.00 Median:25550.00 stddev:0.00 (0.0%) 06:00:56 INFO - 2015-11-21 06:00:56,237 DEBUG : BROWSER_OUTPUT: Values: 25550.0 06:00:56 INFO - 2015-11-21 06:00:56,237 DEBUG : BROWSER_OUTPUT: 06:00:56 INFO - 2015-11-21 06:00:56,237 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:610.94 Median:610.94 stddev:0.00 (0.0%) 06:00:56 INFO - 2015-11-21 06:00:56,237 DEBUG : BROWSER_OUTPUT: Values: 610.9 06:00:56 INFO - 2015-11-21 06:00:56,237 DEBUG : BROWSER_OUTPUT: 06:00:56 INFO - 2015-11-21 06:00:56,237 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4830.92 Median:4830.92 stddev:0.00 (0.0%) 06:00:56 INFO - 2015-11-21 06:00:56,237 DEBUG : BROWSER_OUTPUT: Values: 4830.9 06:00:56 INFO - 2015-11-21 06:00:56,237 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 06:00:56 INFO - 2015-11-21 06:00:56,238 DEBUG : BROWSER_OUTPUT: 06:00:57 INFO - 2015-11-21 06:00:57,118 INFO : Browser exited with error code: 0 06:00:57 INFO - 2015-11-21 06:00:57,136 INFO : Completed test v8_7 (00:00:39) 06:00:57 INFO - 2015-11-21 06:00:57,210 INFO : Completed test suite (00:20:12) 06:00:57 INFO - 2015-11-21 06:00:57,210 DEBUG : Working with test: dromaeo_css 06:00:57 INFO - 2015-11-21 06:00:57,211 DEBUG : Generating results file: dromaeo_css 06:00:57 INFO - 2015-11-21 06:00:57,212 DEBUG : Working with test: kraken 06:00:57 INFO - 2015-11-21 06:00:57,212 DEBUG : Generating results file: kraken 06:00:57 INFO - 2015-11-21 06:00:57,212 INFO : javascript benchmark 06:00:57 INFO - 2015-11-21 06:00:57,212 DEBUG : Working with test: v8_7 06:00:57 INFO - 2015-11-21 06:00:57,212 DEBUG : Generating results file: v8_7 06:00:57 INFO - 2015-11-21 06:00:57,213 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 06:00:57 INFO - 2015-11-21 06:00:57,348 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,1,35]] 06:00:57 INFO - 2015-11-21 06:00:57,348 DEBUG : process_Request line: dromaeo_css 6958.56 graph.html#tests=[[72,1,35]] 06:00:57 INFO - 2015-11-21 06:00:57,348 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 06:00:57 INFO - 2015-11-21 06:00:57,462 DEBUG : process_Request line: kraken 1499.40 graph.html#tests=[[232,1,35]] 06:00:57 INFO - 2015-11-21 06:00:57,462 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 06:00:57 INFO - 2015-11-21 06:00:57,596 DEBUG : process_Request line: v8_7 19936.90 graph.html#tests=[[230,1,35]] 06:00:57 INFO - 2015-11-21 06:00:57,598 INFO : javascript benchmark 06:00:57 INFO - 2015-11-21 06:00:57,601 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3234.110619579616, 3283.835808209589, 3333.133385319816, 3335.5663763710727, 3345.3309338132362, 5280.366356037281, 5432.945670543293, 5496.230527726121, 5532.308461442315, 5536.031194540954, 5452.754626041838, 5499.862503437406, 5537.916931246024, 5554.638948468347, 5615.354234263061, 5014.2979982802435, 5031.949680503185, 5042.218456139304, 5065.164247899111, 5092.694438333693, 4902.338184345103, 5084.771185296652, 5148.485151484841, 5167.534921857032, 5242.580593552507, 5006.899862002758, 5014.323066386028, 5112.130937740593, 5142.640015198937, 5152.871178220537, 5089.134847076006, 5098.643094983353, 5100.7449627518845, 5125.38495380553, 5160.793568257265, 4984.953159836438, 5049.419316778581, 5049.924251136199, 5057.974710126426, 5077.949220507785, 5098.566621837148, 5189.221616757479, 5245.86885327866, 5355.6251062425645, 5393.4336894626285, 5948.643081415085, 5973.581849270553, 5991.400859914017, 5991.880162396771, 5997.490213331872, 5875.882482350329, 6039.124326972608, 6058.1518587397795, 6064.332923378425, 6078.787242446538, 5504.0643090675085, 5534.391216966131, 5535.25274087997, 5581.916271255935, 5636.379998200195, 6118.663473508911, 6141.109539116893, 6183.567150299526, 6193.102000210034, 6206.255249370104, 5615.971920140373, 5931.940680593225, 5932.495737862244, 5935.821925342247, 5938.584299099021, 5876.882462350814, 5923.437273459014, 5939.613925094855, 5967.671778052249, 6028.9397106029255, 5896.705164741746, 5899.852503687443, 5903.996320625504, 5974.940250597525, 6007.549433792396, 5710.400407957188, 5912.0, 5914.2311499504785, 5926.7925622603, 5928.3775203603, 4513.11994161142, 4559.817607295671, 4593.885152871138, 4625.884352891205, 4629.8842528936375, 4093.201825643971, 4096.774677392712, 4100.159467309194, 4136.875893723193, 4142.751434913915, 5415.458454154553, 5714.714264286769, 5718.513926316226, 5718.599698021182, 5725.971370143123, 5877.706114694248, 5896.145058966512, 5923.911141332884, 5951.642901425928, 5971.4924231439945, 5634.1830434586755, 5755.22304488897, 5763.0, 5763.971180144156, 5767.163761254678, 5113.616478764107, 5246.7638956247065, 5293.497117773805, 5296.761645725952, 5300.655457395257, 6118.357572454828, 6131.816045518642, 6206.875862482815, 6232.688365581794, 6237.688115594202, 5985.970070149796, 6003.701800511887, 6007.038873780174, 6011.158437818796, 6069.0592958091565, 5910.645361278337, 5965.373635768182, 6190.7214175363115, 6230.6884655767935, 6239.656818874824, 5745.97127014379, 5894.587378883437, 5964.910526342195, 5978.342382338026, 6027.095935609694, 5973.940260597338, 6012.488938440281, 6012.909806352821, 6020.608660437058, 6039.969800150971, 5540.168974653673, 5700.287464066992, 5847.327557330961, 5850.765969361178, 5855.3559108498885, 5708.743106560298, 5751.539876809761, 5823.883522329615, 5829.417058294306, 5843.824685259449, 5598.524125449219, 5672.602917795714, 5678.630888992202, 5687.857803554944, 5691.971540142273, 5669.007923613269, 5699.401562836008, 5713.228714123707, 5720.685362305113, 5784.595078344475, 5458.208559758733, 5603.691796951207, 5607.523360514402, 5663.915041274467, 5765.827025189251], "unit": "ms", "name": "dojo.html", "value": 5486.955548628748}, {"lowerIsBetter": false, "replicates": [579.5189992306384, 591.8786648737009, 598.1595857819764, 618.4217756397766, 630.5775130662456, 32390.67609323906, 40787.79606101969, 41340.58659413409, 41378.37932431016, 41402.58597414025, 44101.11797764043, 44356.556434435646, 44614.77692611532, 44653.553464465345, 44669.88325291861, 7600.0, 7779.844403111934, 8701.695440659594, 8879.378443508956, 8892.0, 10134.074525840068, 10320.845187322197, 10325.483725813718, 10338.431386273753, 10347.74130646736, 10071.446070466121, 10143.543540540657, 10146.64486742964, 10163.0, 10163.542640581154, 10063.69808905734, 10135.290529662927, 10151.0, 10162.288639795217, 10163.288569800154, 9970.302078854484, 10087.092161705481, 10097.0, 10356.171506279556, 10376.533056012497, 40300.19399611992, 40608.0, 40637.79681101605, 40735.59264407348, 40762.0, 3416.6241713411505, 3512.420450625669, 3753.0, 3857.3828187489867, 4144.668426525871, 30243.243918901982, 30292.091237262917, 30959.0712278632, 31281.530777038362, 31670.366592668248, 3905.2324945567275, 3910.1006768443417, 3975.8210880510446, 4034.4150098235887, 4093.97953010236, 286095.0, 286265.0, 287262.0, 287665.0, 289431.0, 56626.0, 57574.13638795421, 59639.701801490715, 59711.40288597145, 60024.69987650034, 63223.0, 63392.0, 64026.0, 64084.35915640784, 64098.0, 14243.78634320486, 14353.6411589709, 14365.712685746226, 14406.0, 14411.42354305816, 10532.946705329407, 10544.314619549705, 10547.103496202755, 10549.525271362807, 10555.313904596176, 19463.31878384278, 19734.0, 19763.60472790536, 19861.0, 19861.702074468896, 7225.24134965821, 7383.261673832574, 7387.298206670358, 7424.777256682308, 7428.4428667850125, 907.5915837872983, 1000.8348622477355, 1014.9039037839116, 1027.3527677563088, 1063.6277302943909, 25370.365740856258, 25505.34900122188, 26814.195574132806, 26828.0, 26907.86546067296, 999.7200783780553, 1051.8842927277992, 1052.8631277933819, 1124.0108704340128, 1163.9301641901343, 15063.54809355721, 15482.30329635169, 15599.61000974962, 15745.370185192693, 15974.92012539953, 328838.0, 333615.0, 333775.0, 334072.0, 334213.0, 46640.0, 46926.296105558446, 46941.29588056182, 46953.5304646956, 47028.5297147031, 1314.967125821843, 1324.0863803975226, 1331.3557756171122, 1338.1703343927022, 1339.36380219395, 25499.6175057378, 26728.198154055408, 28106.859465702542, 28289.57565636476, 28530.57204141981, 43922.560774393125, 44270.0, 44311.778441107585, 44334.778326108164, 44352.778236108614, 273959.0, 274136.0, 275897.0, 277730.0, 277833.0, 27849.582256265767, 28345.0, 30630.0, 31825.5226171603, 32187.195320117185, 38522.80738596289, 38724.41913371358, 38810.223795523365, 38995.805020974716, 39561.60438395695, 32718.34563308768, 32890.5066423999, 32988.17529561684, 33092.503612446315, 35047.0, 28428.57357139603, 30858.69141308558, 32266.83866580652, 32935.835320823244, 37931.81034094812, 33746.83126584352, 35004.0, 35070.649293506736, 35093.12267193238, 35096.824515877255, 29211.0, 31512.212194695316, 31797.523037154, 32389.67610323961, 32612.0, 24346.391340215927, 24440.75559244456, 24669.136580219605, 25003.374915627253, 25047.373815654755], "unit": "ms", "name": "ext.html", "value": 18541.094696046395}, {"lowerIsBetter": false, "replicates": [349.91077275294793, 357.36032501821734, 358.66823188550586, 359.5128600745989, 360.9639036096391, 13944.302784860742, 14239.074460160082, 16440.91779541102, 16804.91597542012, 17537.54474373587, 13890.930545347259, 14875.256237188152, 15150.924245378757, 15152.696946061073, 15903.204839757995, 5274.997750427416, 5337.4662533746705, 5342.118550439173, 5363.54409875161, 5364.973175134119, 3982.7012974027066, 4099.098198396348, 5338.199270109495, 5371.221172929922, 5828.50457711093, 5925.0, 5991.131285963533, 5993.610415323012, 5997.100434934773, 5998.40015998401, 5801.303843538782, 5930.347661757203, 5934.495567876757, 5934.6142500737315, 5976.193213916109, 5200.323957885488, 5202.947970520284, 5224.973875130638, 5236.6857988520815, 5238.947610523884, 19695.212191512466, 20487.0, 20709.58580828375, 20718.689219661715, 20755.066022029045, 2092.5396412789164, 2183.0, 2202.174184680745, 2222.9333120006427, 2403.375122468171, 13107.410166542528, 13178.67053323665, 13246.933765331112, 13529.32353382327, 13592.25242611656, 1792.4085051932832, 1801.927922883083, 1817.781866176054, 1828.4971632800953, 1859.6373707127116, 57118.143227851615, 58628.41371586315, 59896.0, 60296.39703602951, 61177.38822611761, 8889.19997200255, 9351.345405821527, 9440.527973601293, 9531.332806703604, 9613.567389467491, 12064.638060858188, 12108.394580270951, 12144.089193310538, 12148.0, 12205.938970305091, 6725.19297684281, 6738.427233685192, 6742.157230346207, 6809.489288303397, 6891.931080689229, 6749.898751518731, 6824.0, 6890.379865812101, 6915.89626155598, 6969.54697944632, 3949.9012524686536, 3988.4216788565495, 4002.399640053957, 4008.318585840414, 4018.738781979162, 1595.6728870581503, 1633.0609899307944, 1638.6313079557003, 1644.597073716947, 1679.2107709376573, 929.3587424676952, 967.6806653804227, 981.7972983095793, 982.4350998175935, 991.6925753016588, 15932.920335398481, 16572.0, 16743.0, 17057.232424540925, 17104.74342884858, 878.5168157513469, 879.3229213505565, 917.454114801692, 946.7491114854569, 984.9756253496283, 9342.57958391874, 9544.52277386128, 9557.378770379903, 9602.07958408321, 9705.757356066155, 552447.0, 553221.0, 555246.0, 570647.0, 578012.0, 79567.0, 79661.20338796654, 80231.0, 80470.36707430541, 81239.5938020306, 1061.0291583201438, 1065.1744897704186, 1066.1524088349781, 1073.8926107389354, 1075.4138994247996, 14888.404463821325, 14959.700805984037, 15141.848581514043, 15167.165805880783, 15201.92399038042, 35624.0, 35649.643503564635, 36178.8191059043, 36542.45186322154, 36624.81687591545, 49333.75333123455, 50157.74921125371, 50601.74699126481, 52755.0, 53036.73481632567, 9033.141851524095, 9354.485503297385, 9355.85966210521, 9516.33385662997, 9769.364991275828, 10933.671989839999, 10936.398498082683, 10951.890481095406, 11037.0, 11675.591354302558, 11625.534978600761, 13128.868711312765, 14131.434742610181, 14334.21161836109, 14418.13491190532, 13640.727185456433, 13759.518416855362, 13857.168569885838, 14214.786778198128, 14416.207108609127, 14338.283085845875, 14390.136591804525, 14398.928005359907, 14677.92661036688, 14768.852311476749, 8340.916590834015, 8414.074451810418, 8755.868661969947, 9150.267978561566, 9233.676821311223, 13799.862001379857, 13849.307534623027, 14233.857661423668, 14253.714925701635, 14394.856051439352], "unit": "ms", "name": "jquery.html", "value": 8689.67904041141}, {"lowerIsBetter": false, "replicates": [1486.4648726458465, 1649.4721689059502, 1695.1608953567986, 1711.7175666015116, 1738.9826101738984, 6350.682465876705, 6994.580325180493, 7116.110486189226, 7116.395106415948, 7127.536710113839, 7330.120385553728, 7423.220561840996, 7426.628668566564, 7428.442866784986, 7438.293362130603, 1749.4751574527654, 1786.4729904678086, 2213.6236839737285, 2222.1111555377856, 2246.696695946043, 2224.3660556741333, 2225.499262665903, 2226.198568515333, 2228.8996995135176, 2229.1306390507634, 2162.524244666171, 2255.3121298004103, 2259.6949411829355, 2265.3883451468096, 2268.0134141648355, 1963.0381113254546, 1992.3624440179149, 2183.0503730877117, 2220.378294077661, 2226.220822712054, 2193.4954960359046, 2217.3347995601257, 2224.2659922225625, 2247.2359397804826, 2249.224017713886, 7470.103587569526, 7523.661435235427, 7526.247375262485, 7528.8117797054965, 7534.510256833289, 4542.8864278392975, 4588.541145885385, 4605.562471565196, 4612.76936153191, 4620.8151673933, 2978.568107624404, 3043.8782448702027, 3092.567040614293, 3099.628044634636, 3102.410541997036, 971.771633666088, 974.7758015656368, 980.6420656460411, 986.0977205856633, 1025.067188858143, 10016.0, 10175.643852465202, 10184.694459166238, 10188.643397481126, 10190.439525826077, 3932.174243408859, 3976.5029371328583, 4039.111395492987, 4066.369712694537, 4070.592940705965, 8202.138775428613, 8214.548199848947, 8233.588320583947, 8237.95881020603, 8268.297194738394, 4530.29780384041, 4550.408446901882, 4555.385023021916, 4559.658025648089, 4560.042391097841, 4164.3961625564125, 4186.434831297796, 4194.0563373240775, 4195.286801243796, 4201.390798334285, 3399.133221028622, 3419.9658003420145, 3443.380191565492, 3448.896533103961, 3449.5688038995127, 1059.4967390489455, 1078.4014871746099, 1080.8162612355918, 1095.5617752898904, 1096.6545538155615, 931.9487428191514, 999.4003597841382, 1021.2851004297022, 1182.184292837939, 1265.2092442223611, 6218.067289906459, 7098.787036388917, 7261.600611966287, 7293.452991025694, 7301.59841208728, 602.4848754315085, 624.1044101714054, 625.6934102289845, 627.0312367392389, 632.6235889645653, 5280.20796880471, 5502.449755024466, 5503.257060296809, 5515.227868098469, 5554.944450555443, 8855.424397414148, 8898.510581918057, 8984.595693193822, 8986.236169925498, 8991.055939126429, 8857.335699822539, 8895.421797583136, 8898.4660920345, 8902.73291801247, 8903.797987271635, 6705.463562914955, 6837.042814006043, 6846.623435710984, 6861.965690171617, 6904.861902761917, 6739.359760822714, 6769.086173366532, 6770.898436523555, 6774.830629234309, 6778.084958530535, 7730.690772369042, 7927.286544211049, 8051.194880511902, 8071.354291656536, 8076.757697269091, 8110.513369197867, 8118.715844945398, 8168.469049511763, 8209.671613135408, 8210.261076503144, 6406.458155210556, 6539.659369829269, 6584.572002819801, 6606.042123892104, 6606.108175396452, 7342.375898048512, 7381.741639042608, 7388.519746216479, 7406.629668516661, 7408.259174082548, 6651.800445986628, 6726.327367263235, 6759.628220447923, 6808.421284190701, 6914.170299563883, 6746.898796518154, 6769.864602708017, 6845.657717114224, 6917.550359226634, 6949.826254343682, 6711.697973591103, 6731.596104233761, 6774.661266936732, 6816.0, 6821.727130914708, 6050.515958723204, 6078.3921607838865, 6124.5712800103565, 6133.570650054453, 6136.723847426966, 6319.52603554726, 6330.936690633035, 6346.714397852015, 6380.872382552416, 6392.169018027626], "unit": "ms", "name": "mootools.html", "value": 4235.996632932867}, {"lowerIsBetter": false, "replicates": [323.54218780425697, 325.29573473430025, 331.7826823430654, 332.73381294964025, 334.34134754533574, 5989.82030539084, 6013.428724271193, 6048.758049678007, 6080.0, 6112.144299798032, 5749.971250143754, 5859.355470898197, 5915.467607915287, 6013.0, 6047.5766696331275, 4650.209464391061, 4657.580817726404, 4669.392978912753, 4675.509071547481, 4690.038542098861, 4377.1683380157665, 4669.509701481346, 4673.6027437667835, 4673.742944138071, 4678.181318269306, 4429.1806015887005, 4455.153520831048, 4536.27419612862, 4560.384348112995, 4588.518205588415, 4583.724976501404, 4593.632509399274, 4603.539646035403, 4604.2964103282, 4607.10161518504, 4027.556968733437, 4028.133951200506, 4030.7581545107387, 4038.697097717683, 4045.0, 5584.21820945068, 5727.513161381287, 5727.914081288784, 5733.684647344436, 5743.483086522233, 5250.7112108834, 5253.9737301313635, 5259.631825772198, 5262.947370526284, 5272.9736351318, 6398.29618741938, 6398.360163983611, 6405.519586031066, 6415.326390728999, 6419.422251997296, 4366.585174408426, 4369.6285815705705, 4372.344148377737, 4377.912441751179, 4383.736975781431, 6497.93502064978, 6552.836179095513, 6596.043573681837, 6607.6696165192025, 6621.370969757865, 4483.887902802456, 4485.730856148642, 4488.371627972087, 4499.0776890737325, 4503.211937910853, 4524.0, 4532.478764942074, 4534.523874993079, 4547.386102876069, 4552.635789136861, 5293.867653308621, 5297.337832770903, 5298.15229563268, 5305.734713264322, 5313.654612450256, 6318.905216421757, 6437.613743175424, 6472.579282346633, 6481.351864813575, 6481.611103333815, 1598.0890892191571, 1620.5786495511015, 1621.0678859655745, 1621.481126039656, 1625.2280166920855, 1068.1721665708983, 1068.3803394031443, 1070.117153348475, 1085.451846817368, 1088.6733979806027, 6178.258608966953, 6241.407066328691, 6245.0, 6245.250569931637, 6255.499560035186, 6446.3553644636095, 6639.070530125786, 6641.900371494431, 6650.600963942179, 6659.2008958925235, 6171.691415429211, 6224.906626400608, 6264.373562643699, 6299.181106456132, 6306.306306306303, 3566.054995426214, 3619.4027985382118, 3622.1487950331652, 3622.8731994380596, 3634.2186429917697, 6750.291219421988, 6931.965340173267, 6937.618430986344, 6938.340857618518, 6942.583444993316, 6844.1444819397575, 6849.691763870638, 6852.828679282959, 6855.245922948472, 6863.622500762506, 6921.307869213139, 6922.376986071277, 6924.23833378328, 6929.826754331081, 6949.2008419031445, 6574.4740420765265, 6632.137822083098, 6683.298253683293, 6687.531872768859, 6697.564658297195, 6629.370209830058, 6635.867282654416, 6640.369164929324, 6651.833704157435, 6653.63405012729, 6881.587104773729, 6914.51598388108, 6917.273686263071, 6937.93062069393, 6948.062011628365, 4497.257952437942, 4563.908721825611, 4573.085382923495, 4573.862784116482, 4575.0, 6615.4376877965915, 6652.4345430637, 6668.599884006975, 6671.232808226922, 6671.733130674718, 6429.164208652845, 6435.324290949383, 6444.9033264502, 6448.806535803933, 6450.193725784277, 6262.780802671885, 6423.710933007932, 6434.678266086583, 6435.452986496013, 6437.613743175424, 6351.237851457855, 6355.713992870239, 6367.204099487564, 6368.745250189941, 6375.0, 6496.058071579689, 6497.285298617243, 6505.804825855232, 6506.934930650633, 6510.153680021756, 6196.535259855439, 6336.841578960563, 6337.049442583465, 6349.746010159727, 6354.872902541831], "unit": "ms", "name": "prototype.html", "value": 4835.181216281437}, {"lowerIsBetter": false, "replicates": [803.7026300268901, 811.2009670474582, 832.9500229986197, 842.9747107586775, 863.0592654007133, 12955.935220323898, 13177.275249861254, 13187.93406032971, 13188.736225275488, 13200.999999999987, 13073.542426015092, 13612.183269003866, 13618.727625447485, 13622.386992585332, 13638.931805340984, 670.7752902777576, 683.6479213205204, 803.1045384396415, 824.3364091906013, 826.5082276045744, 806.8386322735447, 826.243986752121, 826.3926014379456, 828.3207769628876, 833.9082700902895, 844.9197326253995, 862.4609618988133, 865.3034307382586, 866.8656358264448, 867.6182479708939, 696.0325148044222, 705.3369832357594, 848.3340577646549, 859.4370687199894, 860.3375400941303, 617.4967401567708, 621.8414304352361, 628.4092952624518, 629.4523764325066, 631.4821846086211, 13011.349432528335, 13103.47586096555, 13113.934430327883, 13142.0, 13183.340832958409, 11916.404179790976, 11935.0, 12029.699257518545, 12098.879011209863, 12180.939095304555, 10238.385696858139, 10395.975751322, 10455.634052808191, 10515.84226236607, 10591.523381447776, 3510.613832478425, 3511.525943997553, 3566.7146628269675, 3569.321828852536, 3571.017970058229, 45313.0, 45339.54660453386, 45382.77308613436, 45401.31898021532, 45428.09143817105, 9789.265805064648, 10080.546375413123, 10163.237757168243, 10223.539940702687, 10565.788684226272, 18206.271749129886, 18227.72658410125, 18229.27082916695, 18265.36071237527, 18281.99449030316, 7309.488335816548, 7632.771016869503, 7682.270184332479, 7687.5387476751575, 7703.3067023968115, 4120.443740095108, 4265.253580623378, 4300.806463709078, 4303.354496825501, 4326.891827704332, 2951.439226546949, 2952.763778897683, 2972.301509145349, 2982.2544363909024, 2983.731464168192, 528.4952870009132, 537.4625374625375, 546.6037123085731, 547.4334064243488, 553.9556835453154, 508.57025813187795, 606.6875559087074, 621.6611946489174, 632.2570979099539, 634.1692382978313, 8186.304164146114, 8322.209390108052, 8440.366972477088, 8549.401541892132, 8650.548145215125, 582.6300299309969, 590.3240789296232, 605.3492495567283, 671.9664016799238, 682.2597481732377, 3693.5937046925355, 3858.8456461741775, 3879.1271963807917, 3903.941440878389, 3926.1951299983434, 56468.717656411456, 57188.0, 57261.0, 57408.42591574114, 57448.0, 52034.739826300625, 52039.21941170885, 52044.47955520472, 52153.7392313036, 53458.46541534612, 46024.539754602694, 46470.5352946473, 47797.52202478, 47864.282035769495, 48227.276590851165, 8960.731178064669, 9048.0, 9318.254539636948, 9388.530573471162, 9561.665341713286, 33478.66521334756, 33758.83120584382, 33760.49359259564, 34105.65894341025, 34492.0, 43501.3474797872, 44630.776846115565, 44638.55361446344, 44968.32547511855, 45855.54144458513, 10920.672379828618, 11296.83054754163, 11302.943485282522, 11429.59996400122, 11655.30068195911, 12301.32342721159, 12379.133460658028, 12385.442655080724, 12389.380530973234, 12474.750504989668, 11601.12991525622, 11702.122340824302, 11705.88294117082, 11775.352355620524, 12174.939125304316, 10595.894041059799, 10973.780524389627, 11091.0, 11363.772724545628, 11516.136289778467, 11032.28290161137, 11302.208845380745, 11480.483378247833, 11535.307881527135, 11869.0, 9755.612954500242, 9941.204703623549, 10068.899311006797, 10123.59505619767, 10189.541470633987, 8748.343874209588, 9066.637334506546, 9954.153896918842, 10016.499175041365, 10020.949895250476], "unit": "ms", "name": "yui.html", "value": 6269.560072472658}], "name": "dromaeo_css", "value": 6958.558419744503}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [111.0, 111.0, 104.0, 111.0, 111.0, 111.0, 100.0, 111.0, 109.0, 111.0], "unit": "ms", "name": "ai-astar", "value": 109.0}, {"lowerIsBetter": true, "replicates": [149.0, 123.0, 151.0, 172.0, 133.0, 164.0, 149.0, 126.0, 169.0, 125.0], "unit": "ms", "name": "audio-beat-detection", "value": 146.1}, {"lowerIsBetter": true, "replicates": [161.0, 160.0, 161.0, 160.0, 158.0, 160.0, 160.0, 163.0, 160.0, 160.0], "unit": "ms", "name": "audio-dft", "value": 160.3}, {"lowerIsBetter": true, "replicates": [72.0, 71.0, 81.0, 90.0, 72.0, 72.0, 72.0, 98.0, 91.0, 72.0], "unit": "ms", "name": "audio-fft", "value": 79.1}, {"lowerIsBetter": true, "replicates": [90.0, 90.0, 137.0, 90.0, 90.0, 91.0, 140.0, 90.0, 90.0, 135.0], "unit": "ms", "name": "audio-oscillator", "value": 104.3}, {"lowerIsBetter": true, "replicates": [109.0, 109.0, 109.0, 109.0, 110.0, 108.0, 109.0, 109.0, 110.0, 110.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 109.2}, {"lowerIsBetter": true, "replicates": [146.0, 145.0, 145.0, 145.0, 147.0, 145.0, 145.0, 145.0, 146.0, 145.0], "unit": "ms", "name": "imaging-darkroom", "value": 145.4}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 95.0, 96.0, 96.0, 96.0, 96.0, 96.0, 95.0, 96.0], "unit": "ms", "name": "imaging-desaturate", "value": 95.8}, {"lowerIsBetter": true, "replicates": [61.0, 59.0, 59.0, 63.0, 62.0, 61.0, 61.0, 68.0, 58.0, 57.0], "unit": "ms", "name": "json-parse-financial", "value": 60.9}, {"lowerIsBetter": true, "replicates": [69.0, 69.0, 68.0, 69.0, 69.0, 69.0, 70.0, 69.0, 69.0, 70.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 69.1}, {"lowerIsBetter": true, "replicates": [84.0, 85.0, 85.0, 86.0, 85.0, 87.0, 87.0, 86.0, 86.0, 86.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 85.7}, {"lowerIsBetter": true, "replicates": [117.0, 116.0, 113.0, 113.0, 117.0, 122.0, 126.0, 124.0, 117.0, 122.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 118.7}, {"lowerIsBetter": true, "replicates": [150.0, 145.0, 153.0, 152.0, 144.0, 140.0, 152.0, 151.0, 144.0, 145.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 147.6}, {"lowerIsBetter": true, "replicates": [68.0, 67.0, 68.0, 68.0, 66.0, 67.0, 68.0, 69.0, 68.0, 73.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 68.2}], "name": "kraken", "value": 1499.3999999999999}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [162.89297931259162], "unit": "score", "name": "Richards", "value": 216.71897800000008}, {"lowerIsBetter": false, "replicates": [194.96977968414896], "unit": "score", "name": "DeltaBlue", "value": 339.11922200000015}, {"lowerIsBetter": false, "replicates": [285.38812785388126], "unit": "score", "name": "Encrypt", "value": 932.6982240000001}, {"lowerIsBetter": false, "replicates": [5030.150753768844], "unit": "score", "name": "Decrypt", "value": 52.91710189810189}, {"lowerIsBetter": false, "replicates": [1970.4724409448818], "unit": "score", "name": "RayTrace", "value": 375.5388731268733}, {"lowerIsBetter": false, "replicates": [758.7253414264036], "unit": "score", "name": "Earley", "value": 878.3982340000001}, {"lowerIsBetter": false, "replicates": [12192.77108433735], "unit": "score", "name": "Boyer", "value": 54.66050296442688}, {"lowerIsBetter": false, "replicates": [25550.0], "unit": "score", "name": "RegExp", "value": 35.65499021526421}, {"lowerIsBetter": false, "replicates": [610.9422492401216], "unit": "score", "name": "Splay", "value": 133.3857661691542}, {"lowerIsBetter": false, "replicates": [4830.917874396136], "unit": "score", "name": "NavierStokes", "value": 307.1879999999999}], "name": "v8_7", "value": 19936.899391509938}]} 06:00:57 INFO - RETURN: dromaeo_css: 6958.56 06:00:57 INFO - RETURN: kraken: 1499.40 06:00:57 INFO - RETURN: v8_7: 19936.90 06:00:57 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,1,35]]", "result": "19936.90"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,1,35]]", "result": "1499.40"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,1,35]]", "result": "6958.56"}}} 06:00:57 INFO - Return code: 0 06:00:57 INFO - # TBPL SUCCESS # 06:00:57 INFO - Running post-action listener: _resource_record_post_action 06:00:57 INFO - Running post-run listener: _resource_record_post_run 06:00:58 INFO - Total resource usage - Wall time: 1228s; CPU: 13.0%; Read bytes: 0; Write bytes: 506720256; Read time: 0; Write time: 761420 06:00:58 INFO - install - Wall time: 15s; CPU: 15.0%; Read bytes: 0; Write bytes: 161636352; Read time: 0; Write time: 245456 06:00:58 INFO - run-tests - Wall time: 1213s; CPU: 13.0%; Read bytes: 0; Write bytes: 332849152; Read time: 0; Write time: 480960 06:00:58 INFO - Running post-run listener: _upload_blobber_files 06:00:58 INFO - Blob upload gear active. 06:00:58 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 06:00:58 INFO - Copying logs to upload dir... 06:00:58 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1266.568921 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 6 secs) (at 2015-11-21 06:00:58.247609) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-21 06:00:58.251179) ========= 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=8e92d6ac3b8b0dffa3775d33000001f9-1448108862.287650-2094211711 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/xCuxb0UzSd-WXWD66VASLA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.010141 build_url: 'https://queue.taskcluster.net/v1/task/xCuxb0UzSd-WXWD66VASLA/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-21 06:00:58.301081) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-21 06:00:58.301375) ========= 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=8e92d6ac3b8b0dffa3775d33000001f9-1448108862.287650-2094211711 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004640 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-21 06:00:58.350309) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-21 06:00:58.350599) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-21 06:00:58.350882) ========= ========= Total master_lag: 0.22 =========