builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-029 starttime: 1448009543.36 results: success (0) buildid: 20151119223034 builduid: 9c993d68588d47dbbed489abf9fe8ada revision: 3835b568092ae3b71adc931d24928670ad7141a7 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-11-20 00:52:23.362858) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-11-20 00:52:23.363321) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-20 00:52:23.363657) ========= 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=1d09c2d9237d126f9c84bbb400000198-1448008032.272440-202366886 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006420 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-20 00:52:23.390016) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-20 00:52:23.390301) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-20 00:52:23.418459) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-20 00:52:23.418780) ========= 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=1d09c2d9237d126f9c84bbb400000198-1448008032.272440-202366886 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014768 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-20 00:52:23.468576) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-20 00:52:23.468861) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-20 00:52:23.469214) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-20 00:52:23.469483) ========= 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=1d09c2d9237d126f9c84bbb400000198-1448008032.272440-202366886 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-11-20 00:52:23-- 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% 83.1M=0s 2015-11-20 00:52:23 (83.1 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.179789 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-20 00:52:23.661297) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-20 00:52:23.661598) ========= 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=1d09c2d9237d126f9c84bbb400000198-1448008032.272440-202366886 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.084220 ========= master_lag: 0.01 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-20 00:52:23.756402) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-11-20 00:52:23.756764) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 3835b568092ae3b71adc931d24928670ad7141a7 --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 3835b568092ae3b71adc931d24928670ad7141a7 --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=1d09c2d9237d126f9c84bbb400000198-1448008032.272440-202366886 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-11-20 00:52:23,848 truncating revision to first 12 chars 2015-11-20 00:52:23,848 Setting DEBUG logging. 2015-11-20 00:52:23,848 attempt 1/10 2015-11-20 00:52:23,848 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/3835b568092a?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-11-20 00:52:24,821 unpacking tar archive at: mozilla-central-3835b568092a/testing/mozharness/ program finished with exit code 0 elapsedTime=1.302689 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-11-20 00:52:25.071187) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-20 00:52:25.071478) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-20 00:52:25.079202) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-20 00:52:25.079548) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-20 00:52:25.079949) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 28 secs) (at 2015-11-20 00:52:25.080264) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --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-e10s', '--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=1d09c2d9237d126f9c84bbb400000198-1448008032.272440-202366886 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 00:52:25 INFO - MultiFileLogger online at 20151120 00:52:25 in /builds/slave/test-pgo 00:52:25 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --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 00:52:25 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 00:52:25 INFO - {'append_to_log': False, 00:52:25 INFO - 'base_work_dir': '/builds/slave/test-pgo', 00:52:25 INFO - 'blob_upload_branch': 'Firefox', 00:52:25 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 00:52:25 INFO - 'branch': 'Firefox', 00:52:25 INFO - 'buildbot_json_path': 'buildprops.json', 00:52:25 INFO - 'config_files': ('talos/linux_config.py',), 00:52:25 INFO - 'default_actions': ('clobber', 00:52:25 INFO - 'read-buildbot-config', 00:52:25 INFO - 'download-and-extract', 00:52:25 INFO - 'populate-webroot', 00:52:25 INFO - 'create-virtualenv', 00:52:25 INFO - 'install', 00:52:25 INFO - 'run-tests'), 00:52:25 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 00:52:25 INFO - 'download_minidump_stackwalk': True, 00:52:25 INFO - 'download_symbols': 'ondemand', 00:52:25 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 00:52:25 INFO - 'tooltool.py': '/tools/tooltool.py', 00:52:25 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 00:52:25 INFO - '/tools/misc-python/virtualenv.py')}, 00:52:25 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 00:52:25 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 00:52:25 INFO - 'installer_path': 'installer.exe', 00:52:25 INFO - 'log_level': 'info', 00:52:25 INFO - 'log_name': 'talos', 00:52:25 INFO - 'log_to_console': True, 00:52:25 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 00:52:25 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 00:52:25 INFO - 'opt_config_files': (), 00:52:25 INFO - 'pip_index': False, 00:52:25 INFO - 'sps_profile': False, 00:52:25 INFO - 'sps_profile_interval': 0, 00:52:25 INFO - 'suite': 'dromaeojs-e10s', 00:52:25 INFO - 'system_bits': '64', 00:52:25 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 00:52:25 INFO - 'title': 'talos-linux64-ix-029', 00:52:25 INFO - 'tooltool_cache': '/builds/tooltool_cache', 00:52:25 INFO - 'use_talos_json': True, 00:52:25 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 00:52:25 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 00:52:25 INFO - 'work_dir': 'build'} 00:52:25 INFO - ##### 00:52:25 INFO - ##### Running clobber step. 00:52:25 INFO - ##### 00:52:25 INFO - Running pre-action listener: _resource_record_pre_action 00:52:25 INFO - Running main action method: clobber 00:52:25 INFO - rmtree: /builds/slave/test-pgo/build 00:52:25 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 00:52:30 INFO - Running post-action listener: _resource_record_post_action 00:52:30 INFO - ##### 00:52:30 INFO - ##### Running read-buildbot-config step. 00:52:30 INFO - ##### 00:52:30 INFO - Running pre-action listener: _resource_record_pre_action 00:52:30 INFO - Running main action method: read_buildbot_config 00:52:30 INFO - Using buildbot properties: 00:52:30 INFO - { 00:52:30 INFO - "properties": { 00:52:30 INFO - "buildnumber": 550, 00:52:30 INFO - "product": "firefox", 00:52:30 INFO - "script_repo_revision": "production", 00:52:30 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 00:52:30 INFO - "repository": "", 00:52:30 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs-e10s", 00:52:30 INFO - "buildid": "20151119223034", 00:52:30 INFO - "slavename": "talos-linux64-ix-029", 00:52:30 INFO - "pgo_build": "True", 00:52:30 INFO - "basedir": "/builds/slave/test-pgo", 00:52:30 INFO - "project": "", 00:52:30 INFO - "platform": "ubuntu64_hw", 00:52:30 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 00:52:30 INFO - "slavebuilddir": "test", 00:52:30 INFO - "scheduler": "tests-mozilla-central-linux64-pgo-talos", 00:52:30 INFO - "branch": "mozilla-central", 00:52:30 INFO - "repo_path": "mozilla-central", 00:52:30 INFO - "stage_platform": "linux64-pgo", 00:52:30 INFO - "builduid": "9c993d68588d47dbbed489abf9fe8ada", 00:52:30 INFO - "revision": "3835b568092ae3b71adc931d24928670ad7141a7" 00:52:30 INFO - }, 00:52:30 INFO - "sourcestamp": { 00:52:30 INFO - "repository": "", 00:52:30 INFO - "hasPatch": false, 00:52:30 INFO - "project": "", 00:52:30 INFO - "branch": "mozilla-central-linux64-pgo-talos", 00:52:30 INFO - "changes": [ 00:52:30 INFO - { 00:52:30 INFO - "category": null, 00:52:30 INFO - "files": [ 00:52:30 INFO - { 00:52:30 INFO - "url": null, 00:52:30 INFO - "name": "https://queue.taskcluster.net/v1/task/oQVOJ2MoQVmXNwVzk_sSEg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2" 00:52:30 INFO - } 00:52:30 INFO - ], 00:52:30 INFO - "repository": "", 00:52:30 INFO - "rev": "3835b568092ae3b71adc931d24928670ad7141a7", 00:52:30 INFO - "who": "sendchange", 00:52:30 INFO - "when": 1448009500, 00:52:30 INFO - "number": 6687459, 00:52:30 INFO - "comments": "", 00:52:30 INFO - "project": "", 00:52:30 INFO - "at": "Fri 20 Nov 2015 00:51:40", 00:52:30 INFO - "branch": "mozilla-central-linux64-pgo-talos", 00:52:30 INFO - "revlink": "", 00:52:30 INFO - "properties": [ 00:52:30 INFO - [ 00:52:30 INFO - "buildid", 00:52:30 INFO - "20151119223034", 00:52:30 INFO - "Change" 00:52:30 INFO - ], 00:52:30 INFO - [ 00:52:30 INFO - "builduid", 00:52:30 INFO - "9c993d68588d47dbbed489abf9fe8ada", 00:52:30 INFO - "Change" 00:52:30 INFO - ], 00:52:30 INFO - [ 00:52:30 INFO - "pgo_build", 00:52:30 INFO - "True", 00:52:30 INFO - "Change" 00:52:30 INFO - ] 00:52:30 INFO - ], 00:52:30 INFO - "revision": "3835b568092ae3b71adc931d24928670ad7141a7" 00:52:30 INFO - } 00:52:30 INFO - ], 00:52:30 INFO - "revision": "3835b568092ae3b71adc931d24928670ad7141a7" 00:52:30 INFO - } 00:52:30 INFO - } 00:52:30 INFO - Found installer url https://queue.taskcluster.net/v1/task/oQVOJ2MoQVmXNwVzk_sSEg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2. 00:52:30 INFO - Running post-action listener: _resource_record_post_action 00:52:30 INFO - ##### 00:52:30 INFO - ##### Running download-and-extract step. 00:52:30 INFO - ##### 00:52:30 INFO - Running pre-action listener: _resource_record_pre_action 00:52:30 INFO - Running main action method: download_and_extract 00:52:30 INFO - mkdir: /builds/slave/test-pgo/build/tests 00:52:30 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')]} 00:52:30 INFO - https://queue.taskcluster.net/v1/task/oQVOJ2MoQVmXNwVzk_sSEg/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 00:52:30 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/oQVOJ2MoQVmXNwVzk_sSEg/artifacts/public/build/test_packages.json 00:52:30 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/oQVOJ2MoQVmXNwVzk_sSEg/artifacts/public/build/test_packages.json 00:52:30 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/oQVOJ2MoQVmXNwVzk_sSEg/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 00:52:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/oQVOJ2MoQVmXNwVzk_sSEg/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 00:52:41 INFO - Downloaded 1302 bytes. 00:52:41 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 00:52:41 INFO - Using the following test package requirements: 00:52:41 INFO - {u'common': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 00:52:41 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 00:52:41 INFO - u'firefox-45.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 00:52:41 INFO - u'jittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 00:52:41 INFO - u'jsshell-linux-x86_64.zip'], 00:52:41 INFO - u'mochitest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 00:52:41 INFO - u'firefox-45.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 00:52:41 INFO - u'mozbase': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 00:52:41 INFO - u'reftest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 00:52:41 INFO - u'firefox-45.0a1.en-US.linux-x86_64.reftest.tests.zip'], 00:52:41 INFO - u'talos': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 00:52:41 INFO - u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'], 00:52:41 INFO - u'web-platform': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 00:52:41 INFO - u'firefox-45.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 00:52:41 INFO - u'webapprt': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 00:52:41 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 00:52:41 INFO - u'firefox-45.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 00:52:41 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 00:52:41 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')]} 00:52:41 INFO - https://queue.taskcluster.net/v1/task/oQVOJ2MoQVmXNwVzk_sSEg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 00:52:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/oQVOJ2MoQVmXNwVzk_sSEg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 00:52:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/oQVOJ2MoQVmXNwVzk_sSEg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 00:52:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/oQVOJ2MoQVmXNwVzk_sSEg/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 00:52:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/oQVOJ2MoQVmXNwVzk_sSEg/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 00:52:55 INFO - Downloaded 22521768 bytes. 00:52:55 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test-pgo/build/tests 00:52:55 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 00:52:55 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 00:52:56 INFO - Return code: 0 00:52:56 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 00:52: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')]} 00:52:56 INFO - https://queue.taskcluster.net/v1/task/oQVOJ2MoQVmXNwVzk_sSEg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 00:52:56 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/oQVOJ2MoQVmXNwVzk_sSEg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 00:52:56 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/oQVOJ2MoQVmXNwVzk_sSEg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 00:52:56 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/oQVOJ2MoQVmXNwVzk_sSEg/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 00:52:56 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/oQVOJ2MoQVmXNwVzk_sSEg/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 00:53:02 INFO - Downloaded 22521768 bytes. 00:53:02 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 00:53:02 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 00:53:02 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 00:53:03 INFO - Return code: 0 00:53:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:53:03 INFO - https://queue.taskcluster.net/v1/task/oQVOJ2MoQVmXNwVzk_sSEg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 00:53:03 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/oQVOJ2MoQVmXNwVzk_sSEg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 00:53:03 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/oQVOJ2MoQVmXNwVzk_sSEg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 00:53:03 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/oQVOJ2MoQVmXNwVzk_sSEg/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 00:53:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/oQVOJ2MoQVmXNwVzk_sSEg/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 00:53:05 INFO - Downloaded 11130997 bytes. 00:53:05 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 00:53:05 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 00:53:05 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 00:53:05 INFO - Return code: 0 00:53:05 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')]} 00:53:05 INFO - https://queue.taskcluster.net/v1/task/oQVOJ2MoQVmXNwVzk_sSEg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 00:53:05 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/oQVOJ2MoQVmXNwVzk_sSEg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 00:53:05 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/oQVOJ2MoQVmXNwVzk_sSEg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 00:53:05 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/oQVOJ2MoQVmXNwVzk_sSEg/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 00:53:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/oQVOJ2MoQVmXNwVzk_sSEg/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 00:53:09 INFO - Downloaded 57337938 bytes. 00:53:09 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/oQVOJ2MoQVmXNwVzk_sSEg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 00:53:09 INFO - mkdir: /builds/slave/test-pgo/properties 00:53:09 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 00:53:09 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 00:53:09 INFO - Contents: 00:53:09 INFO - build_url:https://queue.taskcluster.net/v1/task/oQVOJ2MoQVmXNwVzk_sSEg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 00:53:09 INFO - Running post-action listener: _resource_record_post_action 00:53:09 INFO - Running post-action listener: set_extra_try_arguments 00:53:09 INFO - ##### 00:53:09 INFO - ##### Running populate-webroot step. 00:53:09 INFO - ##### 00:53:09 INFO - Running pre-action listener: _resource_record_pre_action 00:53:09 INFO - Running main action method: populate_webroot 00:53:09 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 00:53:09 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 00:53:09 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 00:53:09 INFO - '../fennec_ids.txt'], 00:53:09 INFO - 'tests': ['tcheck2']}, 00:53:09 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 00:53:09 INFO - '--tppagecycles', 00:53:09 INFO - '7'], 00:53:09 INFO - 'tests': ['tsvgm']}}, 00:53:09 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 00:53:09 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 00:53:09 INFO - 'tests': ['tresize', 'tcanvasmark']}, 00:53:09 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 00:53:09 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 00:53:09 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 00:53:09 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:53:09 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 00:53:09 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:53:09 INFO - 'talos_options': ['--e10s'], 00:53:09 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 00:53:09 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:53:09 INFO - 'tests': ['damp', 'tps']}, 00:53:09 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:53:09 INFO - 'talos_options': ['--e10s'], 00:53:09 INFO - 'tests': ['damp', 'tps']}, 00:53:09 INFO - 'g3': {'tests': ['dromaeo_dom']}, 00:53:09 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 00:53:09 INFO - 'other': {'tests': ['a11yr', 00:53:09 INFO - 'ts_paint', 00:53:09 INFO - 'tpaint', 00:53:09 INFO - 'sessionrestore', 00:53:09 INFO - 'sessionrestore_no_auto_restore']}, 00:53:09 INFO - 'other-e10s': {'talos_options': ['--e10s'], 00:53:09 INFO - 'tests': ['a11yr', 00:53:09 INFO - 'ts_paint', 00:53:09 INFO - 'tpaint', 00:53:09 INFO - 'sessionrestore', 00:53:09 INFO - 'sessionrestore_no_auto_restore']}, 00:53:09 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 00:53:09 INFO - 'tests': ['a11yr', 00:53:09 INFO - 'ts_paint', 00:53:09 INFO - 'tpaint', 00:53:09 INFO - 'sessionrestore', 00:53:09 INFO - 'sessionrestore_no_auto_restore']}, 00:53:09 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 00:53:09 INFO - 'tests': ['a11yr', 00:53:09 INFO - 'ts_paint', 00:53:09 INFO - 'tpaint', 00:53:09 INFO - 'sessionrestore', 00:53:09 INFO - 'sessionrestore_no_auto_restore']}, 00:53:09 INFO - 'other_l64': {'tests': ['a11yr', 00:53:09 INFO - 'ts_paint', 00:53:09 INFO - 'tpaint', 00:53:09 INFO - 'sessionrestore', 00:53:09 INFO - 'sessionrestore_no_auto_restore']}, 00:53:09 INFO - 'other_nol64': {'tests': ['a11yr', 00:53:09 INFO - 'ts_paint', 00:53:09 INFO - 'tpaint', 00:53:09 INFO - 'sessionrestore', 00:53:09 INFO - 'sessionrestore_no_auto_restore']}, 00:53:09 INFO - 'svgr': {'tests': ['tsvgx', 00:53:09 INFO - 'tsvgr_opacity', 00:53:09 INFO - 'tart', 00:53:09 INFO - 'tscrollx', 00:53:09 INFO - 'cart']}, 00:53:09 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 00:53:09 INFO - 'tests': ['tsvgx', 00:53:09 INFO - 'tsvgr_opacity', 00:53:09 INFO - 'tart', 00:53:09 INFO - 'tscrollx', 00:53:09 INFO - 'cart']}, 00:53:09 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:53:09 INFO - 'tests': ['tp5o']}, 00:53:09 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:53:09 INFO - 'talos_options': ['--e10s'], 00:53:09 INFO - 'tests': ['tp5o']}, 00:53:09 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:53:09 INFO - 'talos_options': ['--xperf_path', 00:53:09 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 00:53:09 INFO - 'tests': ['tp5n']}, 00:53:09 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:53:09 INFO - 'talos_options': ['--e10s', 00:53:09 INFO - '--xperf_path', 00:53:09 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 00:53:09 INFO - 'tests': ['tp5n']}}, 00:53:09 INFO - 'talos.zip': {'path': '', 00:53:09 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 00:53:09 INFO - Running post-action listener: _resource_record_post_action 00:53:09 INFO - ##### 00:53:09 INFO - ##### Running create-virtualenv step. 00:53:09 INFO - ##### 00:53:09 INFO - Running pre-action listener: _resource_record_pre_action 00:53:09 INFO - Running main action method: create_virtualenv 00:53:09 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 00:53:09 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 00:53:09 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 00:53:09 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 00:53:09 INFO - Using real prefix '/usr' 00:53:09 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 00:53:09 INFO - Installing distribute.............................................................................................................................................................................................done. 00:53:11 INFO - Installing pip.................done. 00:53:11 INFO - Return code: 0 00:53:11 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 00:53:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:53:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:53:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:53:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:53:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:53:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:53:11 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--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 0x7f17260d9c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2add6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b8f7c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bd3d70>, '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 0x2bd4b20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bd4fb0>, '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': '1d09c2d9237d126f9c84bbb400000198-1448008032.272440-202366886', '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 00:53:11 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 00:53:11 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 00:53:11 INFO - Using env: {'DISPLAY': ':0', 00:53:11 INFO - 'HOME': '/home/cltbld', 00:53:11 INFO - 'LANG': 'en_US.UTF-8', 00:53:11 INFO - 'LANGUAGE': 'en_US:en', 00:53:11 INFO - 'LOGNAME': 'cltbld', 00:53:11 INFO - 'MAIL': '/var/mail/cltbld', 00:53:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:53:11 INFO - 'MOZ_NO_REMOTE': '1', 00:53:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:53:11 INFO - 'NO_EM_RESTART': '1', 00:53:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:53:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 00:53:11 INFO - 'PWD': '/builds/slave/test-pgo', 00:53:11 INFO - 'SHELL': '/bin/bash', 00:53:11 INFO - 'SHLVL': '1', 00:53:11 INFO - 'TERM': 'linux', 00:53:11 INFO - 'TMOUT': '86400', 00:53:11 INFO - 'USER': 'cltbld', 00:53:11 INFO - 'XDG_SESSION_COOKIE': '1d09c2d9237d126f9c84bbb400000198-1448008032.272440-202366886', 00:53:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:53:11 INFO - '_': '/tools/buildbot/bin/python'} 00:53:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:53:11 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 00:53:11 INFO - Cleaning up... 00:53:12 INFO - Return code: 0 00:53:12 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 00:53:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:53:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:53:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:53:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:53:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:53:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:53:12 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f17260d9c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2add6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b8f7c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bd3d70>, '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 0x2bd4b20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bd4fb0>, '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': '1d09c2d9237d126f9c84bbb400000198-1448008032.272440-202366886', '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 00:53:12 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test-pgo/build 00:53:12 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 00:53:12 INFO - Using env: {'DISPLAY': ':0', 00:53:12 INFO - 'HOME': '/home/cltbld', 00:53:12 INFO - 'LANG': 'en_US.UTF-8', 00:53:12 INFO - 'LANGUAGE': 'en_US:en', 00:53:12 INFO - 'LOGNAME': 'cltbld', 00:53:12 INFO - 'MAIL': '/var/mail/cltbld', 00:53:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:53:12 INFO - 'MOZ_NO_REMOTE': '1', 00:53:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:53:12 INFO - 'NO_EM_RESTART': '1', 00:53:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:53:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 00:53:12 INFO - 'PWD': '/builds/slave/test-pgo', 00:53:12 INFO - 'SHELL': '/bin/bash', 00:53:12 INFO - 'SHLVL': '1', 00:53:12 INFO - 'TERM': 'linux', 00:53:12 INFO - 'TMOUT': '86400', 00:53:12 INFO - 'USER': 'cltbld', 00:53:12 INFO - 'XDG_SESSION_COOKIE': '1d09c2d9237d126f9c84bbb400000198-1448008032.272440-202366886', 00:53:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:53:12 INFO - '_': '/tools/buildbot/bin/python'} 00:53:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:53:12 INFO - Downloading/unpacking psutil>=0.7.1 00:53:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:53:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:53:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:53:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:53:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:53:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:53:13 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 00:53:13 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 00:53:13 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 00:53:13 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 00:53:13 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 00:53:13 INFO - Installing collected packages: psutil 00:53:13 INFO - Running setup.py install for psutil 00:53:14 INFO - building 'psutil._psutil_linux' extension 00:53:14 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 00:53:14 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 00:53:14 INFO - building 'psutil._psutil_posix' extension 00:53:14 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 00:53:14 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 00:53:14 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 00:53:14 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 00:53:14 INFO - Successfully installed psutil 00:53:14 INFO - Cleaning up... 00:53:14 INFO - Return code: 0 00:53:14 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 00:53: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')]} 00:53:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:53:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:53: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')]} 00:53:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:53:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:53: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', '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 0x7f17260d9c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2add6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b8f7c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bd3d70>, '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 0x2bd4b20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bd4fb0>, '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': '1d09c2d9237d126f9c84bbb400000198-1448008032.272440-202366886', '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 00:53: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', 'mozsystemmonitor==0.0.0'] in /builds/slave/test-pgo/build 00:53: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 mozsystemmonitor==0.0.0 00:53:14 INFO - Using env: {'DISPLAY': ':0', 00:53:14 INFO - 'HOME': '/home/cltbld', 00:53:14 INFO - 'LANG': 'en_US.UTF-8', 00:53:14 INFO - 'LANGUAGE': 'en_US:en', 00:53:14 INFO - 'LOGNAME': 'cltbld', 00:53:14 INFO - 'MAIL': '/var/mail/cltbld', 00:53:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:53:14 INFO - 'MOZ_NO_REMOTE': '1', 00:53:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:53:14 INFO - 'NO_EM_RESTART': '1', 00:53:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:53:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 00:53:14 INFO - 'PWD': '/builds/slave/test-pgo', 00:53:14 INFO - 'SHELL': '/bin/bash', 00:53:14 INFO - 'SHLVL': '1', 00:53:14 INFO - 'TERM': 'linux', 00:53:14 INFO - 'TMOUT': '86400', 00:53:14 INFO - 'USER': 'cltbld', 00:53:14 INFO - 'XDG_SESSION_COOKIE': '1d09c2d9237d126f9c84bbb400000198-1448008032.272440-202366886', 00:53:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:53:14 INFO - '_': '/tools/buildbot/bin/python'} 00:53:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:53:14 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 00:53: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 00:53: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 00:53: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 00:53: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 00:53: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 00:53: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 00:53:16 INFO - Downloading mozsystemmonitor-0.0.tar.gz 00:53:16 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 00:53:16 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 00:53:16 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 00:53:16 INFO - Installing collected packages: mozsystemmonitor 00:53:16 INFO - Running setup.py install for mozsystemmonitor 00:53:16 INFO - Successfully installed mozsystemmonitor 00:53:16 INFO - Cleaning up... 00:53:16 INFO - Return code: 0 00:53:16 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 00:53:16 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')]} 00:53:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:53:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:53:16 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')]} 00:53:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:53:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:53:16 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 0x7f17260d9c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2add6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b8f7c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bd3d70>, '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 0x2bd4b20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bd4fb0>, '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': '1d09c2d9237d126f9c84bbb400000198-1448008032.272440-202366886', '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 00:53:16 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 00:53:16 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 00:53:16 INFO - Using env: {'DISPLAY': ':0', 00:53:16 INFO - 'HOME': '/home/cltbld', 00:53:16 INFO - 'LANG': 'en_US.UTF-8', 00:53:16 INFO - 'LANGUAGE': 'en_US:en', 00:53:16 INFO - 'LOGNAME': 'cltbld', 00:53:16 INFO - 'MAIL': '/var/mail/cltbld', 00:53:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:53:16 INFO - 'MOZ_NO_REMOTE': '1', 00:53:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:53:16 INFO - 'NO_EM_RESTART': '1', 00:53:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:53:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 00:53:16 INFO - 'PWD': '/builds/slave/test-pgo', 00:53:16 INFO - 'SHELL': '/bin/bash', 00:53:16 INFO - 'SHLVL': '1', 00:53:16 INFO - 'TERM': 'linux', 00:53:16 INFO - 'TMOUT': '86400', 00:53:16 INFO - 'USER': 'cltbld', 00:53:16 INFO - 'XDG_SESSION_COOKIE': '1d09c2d9237d126f9c84bbb400000198-1448008032.272440-202366886', 00:53:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:53:16 INFO - '_': '/tools/buildbot/bin/python'} 00:53:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:53:16 INFO - Downloading/unpacking blobuploader==1.2.4 00:53:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:53:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:53:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:53:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:53:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:53:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:53:18 INFO - Downloading blobuploader-1.2.4.tar.gz 00:53:18 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 00:53:18 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 00:53:18 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 00:53:18 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 00:53:18 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 00:53:18 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 00:53:18 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 00:53:18 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 00:53:18 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 00:53:18 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 00:53:18 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 00:53:18 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 00:53:18 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 00:53:18 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 00:53:18 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 00:53:18 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 00:53:18 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 00:53:18 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 00:53:19 INFO - Downloading docopt-0.6.1.tar.gz 00:53:19 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 00:53:19 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 00:53:19 INFO - Installing collected packages: blobuploader, requests, docopt 00:53:19 INFO - Running setup.py install for blobuploader 00:53:19 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 00:53:19 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 00:53:19 INFO - Running setup.py install for requests 00:53:19 INFO - Running setup.py install for docopt 00:53:19 INFO - Successfully installed blobuploader requests docopt 00:53:19 INFO - Cleaning up... 00:53:19 INFO - Return code: 0 00:53:19 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 00:53: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')]} 00:53:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:53:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:53: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')]} 00:53:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:53:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:53:19 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 0x7f17260d9c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2add6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b8f7c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bd3d70>, '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 0x2bd4b20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bd4fb0>, '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': '1d09c2d9237d126f9c84bbb400000198-1448008032.272440-202366886', '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 00:53:19 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 00:53:19 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 00:53:19 INFO - Using env: {'DISPLAY': ':0', 00:53:19 INFO - 'HOME': '/home/cltbld', 00:53:19 INFO - 'LANG': 'en_US.UTF-8', 00:53:19 INFO - 'LANGUAGE': 'en_US:en', 00:53:19 INFO - 'LOGNAME': 'cltbld', 00:53:19 INFO - 'MAIL': '/var/mail/cltbld', 00:53:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:53:19 INFO - 'MOZ_NO_REMOTE': '1', 00:53:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:53:19 INFO - 'NO_EM_RESTART': '1', 00:53:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:53:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 00:53:19 INFO - 'PWD': '/builds/slave/test-pgo', 00:53:19 INFO - 'SHELL': '/bin/bash', 00:53:19 INFO - 'SHLVL': '1', 00:53:19 INFO - 'TERM': 'linux', 00:53:19 INFO - 'TMOUT': '86400', 00:53:19 INFO - 'USER': 'cltbld', 00:53:19 INFO - 'XDG_SESSION_COOKIE': '1d09c2d9237d126f9c84bbb400000198-1448008032.272440-202366886', 00:53:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:53:19 INFO - '_': '/tools/buildbot/bin/python'} 00:53:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:53:20 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 00:53:20 INFO - Running setup.py (path:/tmp/pip-jMeFVO-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 00:53:20 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 00:53:20 INFO - Running setup.py (path:/tmp/pip-lPfzss-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 00:53:20 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 00:53:20 INFO - Running setup.py (path:/tmp/pip-06GScs-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 00:53:20 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 00:53:20 INFO - Running setup.py (path:/tmp/pip-PsVed0-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 00:53:20 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 00:53:20 INFO - Running setup.py (path:/tmp/pip-rM_iM4-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 00:53:20 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 00:53:20 INFO - Running setup.py (path:/tmp/pip-sZaZFz-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 00:53:20 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 00:53:20 INFO - Running setup.py (path:/tmp/pip-6Rp5TU-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 00:53:20 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 00:53:20 INFO - Running setup.py (path:/tmp/pip-8XxnI5-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 00:53:20 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 00:53:20 INFO - Running setup.py (path:/tmp/pip-f8WnyT-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 00:53:20 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 00:53:20 INFO - Running setup.py (path:/tmp/pip-HpSobq-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 00:53:20 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 00:53:20 INFO - Running setup.py (path:/tmp/pip-PLEqbN-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 00:53:20 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 00:53:20 INFO - Running setup.py (path:/tmp/pip-pXV7hu-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 00:53:20 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 00:53:20 INFO - Running setup.py (path:/tmp/pip-L2rmbN-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 00:53:20 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 00:53:20 INFO - Running setup.py (path:/tmp/pip-uTCtam-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 00:53:21 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 00:53:21 INFO - Running setup.py (path:/tmp/pip-umSpp1-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 00:53:21 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 00:53:21 INFO - Running setup.py (path:/tmp/pip-ItVeks-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 00:53:21 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 00:53:21 INFO - Running setup.py (path:/tmp/pip-pQXVaB-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 00:53:21 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 00:53:21 INFO - Running setup.py install for manifestparser 00:53:21 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 00:53:21 INFO - Running setup.py install for mozcrash 00:53:21 INFO - Running setup.py install for mozdebug 00:53:21 INFO - Running setup.py install for mozdevice 00:53:21 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 00:53:21 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 00:53:21 INFO - Running setup.py install for mozfile 00:53:21 INFO - Running setup.py install for mozhttpd 00:53:21 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 00:53:21 INFO - Running setup.py install for mozinfo 00:53:21 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 00:53:21 INFO - Running setup.py install for mozInstall 00:53:22 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 00:53:22 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 00:53:22 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 00:53:22 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 00:53:22 INFO - Running setup.py install for mozleak 00:53:22 INFO - Running setup.py install for mozlog 00:53:22 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 00:53:22 INFO - Running setup.py install for moznetwork 00:53:22 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 00:53:22 INFO - Running setup.py install for mozprocess 00:53:22 INFO - Running setup.py install for mozprofile 00:53:22 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 00:53:22 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 00:53:22 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 00:53:22 INFO - Running setup.py install for mozrunner 00:53:22 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 00:53:22 INFO - Running setup.py install for mozscreenshot 00:53:22 INFO - Running setup.py install for moztest 00:53:22 INFO - Running setup.py install for mozversion 00:53:22 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 00:53:22 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 00:53:22 INFO - Cleaning up... 00:53:23 INFO - Return code: 0 00:53:23 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 00:53:23 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')]} 00:53:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:53:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:53:23 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')]} 00:53:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:53:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:53:23 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 0x7f17260d9c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2add6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b8f7c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bd3d70>, '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 0x2bd4b20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bd4fb0>, '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': '1d09c2d9237d126f9c84bbb400000198-1448008032.272440-202366886', '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 00:53:23 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 00:53:23 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 00:53:23 INFO - Using env: {'DISPLAY': ':0', 00:53:23 INFO - 'HOME': '/home/cltbld', 00:53:23 INFO - 'LANG': 'en_US.UTF-8', 00:53:23 INFO - 'LANGUAGE': 'en_US:en', 00:53:23 INFO - 'LOGNAME': 'cltbld', 00:53:23 INFO - 'MAIL': '/var/mail/cltbld', 00:53:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:53:23 INFO - 'MOZ_NO_REMOTE': '1', 00:53:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:53:23 INFO - 'NO_EM_RESTART': '1', 00:53:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:53:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 00:53:23 INFO - 'PWD': '/builds/slave/test-pgo', 00:53:23 INFO - 'SHELL': '/bin/bash', 00:53:23 INFO - 'SHLVL': '1', 00:53:23 INFO - 'TERM': 'linux', 00:53:23 INFO - 'TMOUT': '86400', 00:53:23 INFO - 'USER': 'cltbld', 00:53:23 INFO - 'XDG_SESSION_COOKIE': '1d09c2d9237d126f9c84bbb400000198-1448008032.272440-202366886', 00:53:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:53:23 INFO - '_': '/tools/buildbot/bin/python'} 00:53:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:53:23 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 00:53:23 INFO - Running setup.py (path:/tmp/pip-COR2x0-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 00:53:23 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)) 00:53:23 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 00:53:23 INFO - Running setup.py (path:/tmp/pip-QelJ9k-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 00:53:23 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)) 00:53:23 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 00:53:23 INFO - Running setup.py (path:/tmp/pip-SW78eL-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 00:53:23 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)) 00:53:23 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 00:53:23 INFO - Running setup.py (path:/tmp/pip-vwxkrv-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 00:53:23 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)) 00:53:23 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 00:53:23 INFO - Running setup.py (path:/tmp/pip-5QyD1x-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 00:53:23 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)) 00:53:23 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 00:53:23 INFO - Running setup.py (path:/tmp/pip-ZsmO6M-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 00:53:23 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)) 00:53:23 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 00:53:23 INFO - Running setup.py (path:/tmp/pip-R6rTdY-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 00:53:23 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)) 00:53:23 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 00:53:23 INFO - Running setup.py (path:/tmp/pip-69oZNb-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 00:53:23 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)) 00:53:23 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 00:53:23 INFO - Running setup.py (path:/tmp/pip-EJGxk2-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 00:53:23 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)) 00:53:23 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 00:53:23 INFO - Running setup.py (path:/tmp/pip-Gu_AOx-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 00:53:23 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)) 00:53:23 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 00:53:23 INFO - Running setup.py (path:/tmp/pip-YxWv_6-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 00:53:24 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)) 00:53:24 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 00:53:24 INFO - Running setup.py (path:/tmp/pip-WhU5zf-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 00:53:24 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)) 00:53:24 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 00:53:24 INFO - Running setup.py (path:/tmp/pip-M6devc-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 00:53:24 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)) 00:53:24 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 00:53:24 INFO - Running setup.py (path:/tmp/pip-zm8DAB-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 00:53:24 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)) 00:53:24 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 00:53:24 INFO - Running setup.py (path:/tmp/pip-6nDBkI-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 00:53:24 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)) 00:53:24 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 00:53:24 INFO - Running setup.py (path:/tmp/pip-WVtC0L-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 00:53:24 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)) 00:53:24 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 00:53:24 INFO - Running setup.py (path:/tmp/pip-ubg28r-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 00:53:24 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)) 00:53:24 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)) 00:53:24 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)) 00:53:24 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)) 00:53:24 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)) 00:53:24 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)) 00:53:24 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.0->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 00:53:24 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 00:53:24 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 00:53:24 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 00:53:24 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 00:53:24 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 00:53:24 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 00:53:26 INFO - Downloading blessings-1.5.1.tar.gz 00:53:26 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 00:53:26 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 00:53:26 INFO - Installing collected packages: blessings 00:53:26 INFO - Running setup.py install for blessings 00:53:26 INFO - Successfully installed blessings 00:53:26 INFO - Cleaning up... 00:53:26 INFO - Return code: 0 00:53:26 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 00:53:26 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 00:53:26 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 00:53:26 INFO - Reading from file tmpfile_stdout 00:53:26 INFO - Current package versions: 00:53:26 INFO - argparse == 1.2.1 00:53:26 INFO - blessings == 1.5.1 00:53:26 INFO - blobuploader == 1.2.4 00:53:26 INFO - docopt == 0.6.1 00:53:26 INFO - manifestparser == 1.1 00:53:26 INFO - mozInstall == 1.12 00:53:26 INFO - mozcrash == 0.16 00:53:26 INFO - mozdebug == 0.1 00:53:26 INFO - mozdevice == 0.47 00:53:26 INFO - mozfile == 1.2 00:53:26 INFO - mozhttpd == 0.7 00:53:26 INFO - mozinfo == 0.9 00:53:26 INFO - mozleak == 0.1 00:53:26 INFO - mozlog == 3.0 00:53:26 INFO - moznetwork == 0.27 00:53:26 INFO - mozprocess == 0.22 00:53:26 INFO - mozprofile == 0.27 00:53:26 INFO - mozrunner == 6.11 00:53:26 INFO - mozscreenshot == 0.1 00:53:26 INFO - mozsystemmonitor == 0.0 00:53:26 INFO - moztest == 0.7 00:53:26 INFO - mozversion == 1.4 00:53:26 INFO - psutil == 3.1.1 00:53:26 INFO - requests == 1.2.3 00:53:26 INFO - wsgiref == 0.1.2 00:53:26 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 00:53:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:53:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:53:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:53:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:53:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:53:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:53:26 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 0x7f17260d9c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2add6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b8f7c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bd3d70>, '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 0x2bd4b20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bd4fb0>, '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': '1d09c2d9237d126f9c84bbb400000198-1448008032.272440-202366886', '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 00:53:26 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 00:53:26 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 00:53:26 INFO - Using env: {'DISPLAY': ':0', 00:53:26 INFO - 'HOME': '/home/cltbld', 00:53:26 INFO - 'LANG': 'en_US.UTF-8', 00:53:26 INFO - 'LANGUAGE': 'en_US:en', 00:53:26 INFO - 'LOGNAME': 'cltbld', 00:53:26 INFO - 'MAIL': '/var/mail/cltbld', 00:53:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:53:26 INFO - 'MOZ_NO_REMOTE': '1', 00:53:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:53:26 INFO - 'NO_EM_RESTART': '1', 00:53:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:53:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 00:53:26 INFO - 'PWD': '/builds/slave/test-pgo', 00:53:26 INFO - 'SHELL': '/bin/bash', 00:53:26 INFO - 'SHLVL': '1', 00:53:26 INFO - 'TERM': 'linux', 00:53:26 INFO - 'TMOUT': '86400', 00:53:26 INFO - 'USER': 'cltbld', 00:53:26 INFO - 'XDG_SESSION_COOKIE': '1d09c2d9237d126f9c84bbb400000198-1448008032.272440-202366886', 00:53:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:53:26 INFO - '_': '/tools/buildbot/bin/python'} 00:53:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:53:26 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)) 00:53:26 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)) 00:53:26 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)) 00:53:26 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)) 00:53:26 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)) 00:53:26 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)) 00:53:26 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)) 00:53:26 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)) 00:53:26 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)) 00:53:26 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)) 00:53:26 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)) 00:53:26 INFO - Cleaning up... 00:53:26 INFO - Return code: 0 00:53:26 INFO - Running post-action listener: _resource_record_post_action 00:53:26 INFO - Running post-action listener: _start_resource_monitoring 00:53:26 INFO - Starting resource monitoring. 00:53:26 INFO - ##### 00:53:26 INFO - ##### Running install step. 00:53:26 INFO - ##### 00:53:26 INFO - Running pre-action listener: _resource_record_pre_action 00:53:26 INFO - Running main action method: install 00:53:26 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 00:53:26 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 00:53:27 INFO - Reading from file tmpfile_stdout 00:53:27 INFO - Detecting whether we're running mozinstall >=1.0... 00:53:27 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 00:53:27 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 00:53:27 INFO - Reading from file tmpfile_stdout 00:53:27 INFO - Output received: 00:53:27 INFO - Usage: mozinstall [options] installer 00:53:27 INFO - Options: 00:53:27 INFO - -h, --help show this help message and exit 00:53:27 INFO - -d DEST, --destination=DEST 00:53:27 INFO - Directory to install application into. [default: 00:53:27 INFO - "/builds/slave/test-pgo"] 00:53:27 INFO - --app=APP Application being installed. [default: firefox] 00:53:27 INFO - mkdir: /builds/slave/test-pgo/build/application 00:53:27 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'] 00:53:27 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 00:53:41 INFO - Reading from file tmpfile_stdout 00:53:41 INFO - Output received: 00:53:41 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 00:53:41 INFO - Running post-action listener: _resource_record_post_action 00:53:41 INFO - ##### 00:53:41 INFO - ##### Running run-tests step. 00:53:41 INFO - ##### 00:53:41 INFO - Running pre-action listener: _resource_record_pre_action 00:53:41 INFO - Running main action method: run_tests 00:53:41 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 00:53:41 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 00:53:41 INFO - Python 2.7.3 00:53:41 INFO - Return code: 0 00:53:41 INFO - grabbing minidump binary from tooltool 00:53:41 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')]} 00:53:41 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 0x2bd3d70>, '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 0x2bd4b20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bd4fb0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 00:53:41 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 00:53:41 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 00:53:41 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 00:53:41 INFO - Return code: 0 00:53:41 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 00:53:41 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 00:53:41 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 00:53:41 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 00:53:41 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 00:53:41 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-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/oQVOJ2MoQVmXNwVzk_sSEg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-029', '--webServer', 'localhost'] in /builds/slave/test-pgo/build 00:53:41 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-e10s --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/oQVOJ2MoQVmXNwVzk_sSEg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-029 --webServer localhost 00:53:41 INFO - Using env: {'DISPLAY': ':0', 00:53:41 INFO - 'HOME': '/home/cltbld', 00:53:41 INFO - 'LANG': 'en_US.UTF-8', 00:53:41 INFO - 'LANGUAGE': 'en_US:en', 00:53:41 INFO - 'LOGNAME': 'cltbld', 00:53:41 INFO - 'MAIL': '/var/mail/cltbld', 00:53:41 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 00:53:41 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 00:53:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:53:41 INFO - 'MOZ_NO_REMOTE': '1', 00:53:41 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 00:53:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:53:41 INFO - 'NO_EM_RESTART': '1', 00:53:41 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:53:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 00:53:41 INFO - 'PWD': '/builds/slave/test-pgo', 00:53:41 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 00:53:41 INFO - 'SHELL': '/bin/bash', 00:53:41 INFO - 'SHLVL': '1', 00:53:41 INFO - 'TERM': 'linux', 00:53:41 INFO - 'TMOUT': '86400', 00:53:41 INFO - 'USER': 'cltbld', 00:53:41 INFO - 'XDG_SESSION_COOKIE': '1d09c2d9237d126f9c84bbb400000198-1448008032.272440-202366886', 00:53:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:53:41 INFO - '_': '/tools/buildbot/bin/python'} 00:53:41 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-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/oQVOJ2MoQVmXNwVzk_sSEg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-029', '--webServer', 'localhost'] with output_timeout 3600 00:53:41 INFO - mozversion INFO | application_buildid: 20151119223034 00:53:41 INFO - mozversion INFO | application_changeset: 3835b568092ae3b71adc931d24928670ad7141a7 00:53:41 INFO - mozversion INFO | application_display_name: Nightly 00:53:41 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 00:53:41 INFO - mozversion INFO | application_name: Firefox 00:53:41 INFO - mozversion INFO | application_remotingname: firefox 00:53:41 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/mozilla-central 00:53:41 INFO - mozversion INFO | application_vendor: Mozilla 00:53:41 INFO - mozversion INFO | application_version: 45.0a1 00:53:41 INFO - mozversion INFO | platform_buildid: 20151119223034 00:53:41 INFO - mozversion INFO | platform_changeset: 3835b568092ae3b71adc931d24928670ad7141a7 00:53:41 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/mozilla-central 00:53:41 INFO - mozversion INFO | platform_version: 45.0a1 00:53:41 INFO - 2015-11-20 00:53:41,774 DEBUG : using testdate: 1448009621 00:53:41 INFO - 2015-11-20 00:53:41,774 DEBUG : actual date: 1448009621 00:53:41 INFO - 2015-11-20 00:53:41,821 INFO : starting webserver on 'localhost:40862' 00:53:41 INFO - 2015-11-20 00:53:41,823 INFO : Starting test suite talos-linux64-ix-029.e 00:53:41 INFO - 2015-11-20 00:53:41,823 INFO : Starting test dromaeo_css 00:53:41 INFO - 2015-11-20 00:53:41,823 DEBUG : operating with platform_type : linux_ 00:53:41 INFO - 2015-11-20 00:53:41,824 INFO : Initialising browser for dromaeo_css test... 00:53:41 INFO - 2015-11-20 00:53:41,840 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpgMg_Je/profile http://localhost:40862/getInfo.html 00:53:46 INFO - 2015-11-20 00:53:46,442 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 00:53:46 INFO - 2015-11-20 00:53:46,443 DEBUG : BROWSER_OUTPUT: colorDepth:24 00:53:46 INFO - 2015-11-20 00:53:46,443 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 00:53:46 INFO - 2015-11-20 00:53:46,443 DEBUG : BROWSER_OUTPUT: __metrics 00:53:47 INFO - 2015-11-20 00:53:47,541 INFO : Browser initialized. 00:53:47 INFO - 2015-11-20 00:53:47,542 INFO : Running cycle 1/1 for dromaeo_css test... 00:53:47 INFO - 2015-11-20 00:53:47,542 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpgMg_Je/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 00:53:59 INFO - 2015-11-20 00:53:59,285 DEBUG : BROWSER_OUTPUT: RSS: Main: 142118912 00:53:59 INFO - 2015-11-20 00:53:59,286 DEBUG : BROWSER_OUTPUT: 00:54:48 INFO - 2015-11-20 00:54:48,895 DEBUG : BROWSER_OUTPUT: 1448009688893 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] 00:56:58 INFO - 2015-11-20 00:56:58,167 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40862/tests/dromaeo/cssquery-dojo.html (next: http://localhost:40862/tests/dromaeo/cssquery-ext.html) 00:56:59 INFO - 2015-11-20 00:56:59,183 DEBUG : BROWSER_OUTPUT: RSS: Main: 148725760 00:56:59 INFO - 2015-11-20 00:56:59,183 DEBUG : BROWSER_OUTPUT: 01:00:01 INFO - 2015-11-20 01:00:01,144 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40862/tests/dromaeo/cssquery-ext.html (next: http://localhost:40862/tests/dromaeo/cssquery-jquery.html) 01:00:01 INFO - 2015-11-20 01:00:01,726 DEBUG : BROWSER_OUTPUT: RSS: Main: 141291520 01:00:01 INFO - 2015-11-20 01:00:01,726 DEBUG : BROWSER_OUTPUT: 01:03:03 INFO - 2015-11-20 01:03:03,348 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40862/tests/dromaeo/cssquery-jquery.html (next: http://localhost:40862/tests/dromaeo/cssquery-mootools.html) 01:03:03 INFO - 2015-11-20 01:03:03,934 DEBUG : BROWSER_OUTPUT: RSS: Main: 143048704 01:03:03 INFO - 2015-11-20 01:03:03,934 DEBUG : BROWSER_OUTPUT: 01:06:05 INFO - 2015-11-20 01:06:05,538 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40862/tests/dromaeo/cssquery-mootools.html (next: http://localhost:40862/tests/dromaeo/cssquery-prototype.html) 01:06:06 INFO - 2015-11-20 01:06:06,151 DEBUG : BROWSER_OUTPUT: RSS: Main: 140967936 01:06:06 INFO - 2015-11-20 01:06:06,151 DEBUG : BROWSER_OUTPUT: 01:09:08 INFO - 2015-11-20 01:09:08,448 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40862/tests/dromaeo/cssquery-prototype.html (next: http://localhost:40862/tests/dromaeo/cssquery-yui.html) 01:09:09 INFO - 2015-11-20 01:09:09,049 DEBUG : BROWSER_OUTPUT: RSS: Main: 140779520 01:09:09 INFO - 2015-11-20 01:09:09,049 DEBUG : BROWSER_OUTPUT: 01:12:11 INFO - 2015-11-20 01:12:11,545 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40862/tests/dromaeo/cssquery-yui.html (next: http://localhost:40862/tests/dromaeo/cssquery-dojo.html) 01:12:11 INFO - 2015-11-20 01:12:11,791 DEBUG : BROWSER_OUTPUT: RSS: Main: 144023552 01:12:11 INFO - 2015-11-20 01:12:11,791 DEBUG : BROWSER_OUTPUT: 01:12:11 INFO - 2015-11-20 01:12:11,793 DEBUG : BROWSER_OUTPUT: __start_tp_report 01:12:11 INFO - 2015-11-20 01:12:11,794 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 01:12:11 INFO - 2015-11-20 01:12:11,794 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 01:12:11 INFO - 2015-11-20 01:12:11,794 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 01:12:11 INFO - 2015-11-20 01:12:11,795 DEBUG : BROWSER_OUTPUT: |0;dojo.html;3254.5931758530182;3334.8832790852325;3355.5302257683943;3376.2065914510085;3381.2223188666608;5383.16560933056;5561.47166019228;5572.164175373696;5607.439256074391;5615.887682246353;5510.9448905510935;5531.917021244684;5537.501624853762;5633.774649014034;5664.631798933066;5023.497650234984;5067.847964561069;5138.254953031808;5155.922661160085;5164.328637277149;5074.314967479399;5186.910748742768;5224.059669259532;5251.658642188265;5279.023380674568;4895.730734809584;4973.5523802857915;5018.473060328686;5089.821856235014;5110.667806592578;5119.846404607868;5122.206058061007;5142.202958541432;5142.871428214325;5150.690958542462;5093.617978651616;5122.462141475166;5132.435432102466;5133.358330208724;5163.380394352665;5195.168772996302;5224.582033437316;5308.734563271821;5312.601554883399;5315.973420132913;5866.823995280149;5876.676782776945;5877.5591830612875;5882.058870580687;5883.499902508292;5781.4507621775865;5920.141579470996;5927.199828023205;5948.167256584082;5972.044472884318;5518.448155184489;5584.413636568183;5587.972060139755;5639.746211420496;5657.066584013633;6041.78853740117;6051.546134039877;6060.121282414026;6101.755929762849;6106.358832322631;5737.282839645044;5816.272965879265;5851.64890106595;5905.291365036137;5932.7330270137945;5932.49573786233;6003.489703375262;6016.338202797776;6017.819465416044;6021.976264035125;5926.081457374114;6021.939780602138;6064.36324185963;6065.029595264737;6068.939310606926;5782.190493330937;5910.8817823643285;5918.644881307049;5991.700414979234;6073.787417440457;4580.541945805393;4644.16405047088;4645.117427688729;4670.953290467051;4686.39076920005;4093.099518106012;4121.381792731055;4128.0711839836395;4143.523494798076;4170.91658166835;5420.051490989061;5548.805791797267;5549.6115271931385;5654.321481422256;5698.715064246771;5882.794102206402;5892.793752218652;5896.380880007623;5898.14476900847;6059.969700151559;5558.77764889408;5565.0817615093865;5569.944300556943;5570.41510641385;5596.468335508121;5056.317397151411;5171.81898633546;5185.351831021122;5230.424653288135;5244.134717771525;6045.1234570987845;6099.176611157525;6128.9693551531955;6133.478654314344;6142.6314421134875;5796.681182534832;5865.501432378295;5867.6772777497645;5873.647581145145;5899.410058994066;6104.084387341934;6133.969330153321;6218.533609979179;6228.377162283736;6232.314445411092;5822.184894114912;5951.7619295227705;6014.6391216527145;6019.307779605401;6026.849328766641;5707.229524014205;5835.79574714883;6016.338202797776;6108.236470441195;6112.358202388685;5788.62373945709;5841.269841269841;5857.150713146655;5857.58996870232;5924.377940316204;5901.468867801918;5919.822405327847;5931.288245410406;5937.435943585352;5938.495227905676;5444.646098003617;5491.203775452617;5608.298962629671;5851.327097383855;5860.062390017577;5753.05074662676;5781.624194427349;5783.219265399285;5790.768369265183;5798.072308430631;5596.832095037155;5633.746481408264;5645.943540564542;5654.208410822406;5671.291088613923 01:12:11 INFO - 2015-11-20 01:12:11,799 DEBUG : BROWSER_OUTPUT: |1;ext.html;578.5574035862563;591.6804925340316;593.2406519654843;595.327280173404;595.4402861310368;30499.390012199772;38977.80511097444;39816.99999999996;39888.60111398885;39966.60033399665;43233.35149972753;43356.13287734243;43406;43626.34560481595;43678.781606092;8620.74137775866;8716.694915677952;8745.868811967794;8818.911810881906;8856.8671469928;8566.31469482443;8691.782705432382;8703.782405439882;8720.912790872073;8755.912440875574;8598.957005214996;8637.136286371344;8711.651533938635;8717.95641021794;8718.520481373522;8795.912040879606;8812.206901378842;8834.072422395653;8867.778305542413;8885.378023538355;8636.784080397978;8712.825743485158;8736.43213191147;8787.824243515093;8788.956055219684;39967.60032399668;40185.39721904174;40263.7986810067;40267;40569;3300.405926933151;3374.5444365010653;3470.1498132957586;3567.661072198137;3650.872219472306;29554.556681649792;30278.697213027808;30340.089797306115;30351.089467315796;30603.846980765175;3889.358255887775;3916.784576848272;4042.43405923171;4050.1494686115952;4089.325261331877;269820;269895;270521;270555;271133.999999998;55309.72345138249;56620.71689641525;58244.7087764567;59329.70335148297;59375.40624593699;54723;54732.452675473534;54821.72589137029;54874.45125548773;55018.449815502136;15683.921580392253;15838.366465341487;15882.285297161656;15913.761293580606;15940.123293218985;10379.584816607252;10391.740206494898;10521.52653130611;10521.789564208826;10529.157667386591;19108;19425.61148777045;19487;19634.31279905225;19722.112504937024;7584.241575842371;7671.693132274647;7687.577183254863;7764.767056988299;7792.220777922275;859.8710193471029;943.528235882059;943.9433633981984;1004.6985904228702;1147.1109889835445;27652.446951060865;28407.431851362857;28612;28630.427391452053;28894.988675396682;981.9361741486781;990.3117333453181;1055.678018204455;1085.3379438542484;1116.553953552951;14713.55859324222;14946.252687365588;15026.248687565578;15125.168115753739;15136.54590362291;313173;316134;316354;317651;318757;51082.23376649353;51173;51271.74364128155;51375.743121284155;51607.741961289954;1313.3761463305045;1331.4607583928525;1337.8260826092546;1343.9193648381324;1347.070521340272;27064.729352707007;27369;28088.719112809427;28518.144455666363;28886.85556572204;42749.57250427456;43021.784891075346;43277.3508397368;43298.8866057724;43345.56654433415;261712;262825;262939;263229;263317;30550.388992220476;31421.52867707032;32024.199395015312;32188.839055804572;32264.516032259064;42567.47670254383;42628.573714262464;43914.56085439232;43915.34126988162;44462.77768611136;32984.240873797;35834.28331433304;36171.457428139125;36191.638083618825;36555.63444365629;35429.46855797114;36229.818850905576;36470;36516.26967460689;36872.26255474929;33307.33385332328;33498;33927.66072339245;35246.29507409786;35428.82285588659;30893.536596950613;31865.36269274648;32143.839280803448;32884.342313154084;32896.83551582227;24020.39949001289;24718.13486527963;24896.62655060212;24933.252002439956;25069.87465062663 01:12:11 INFO - 2015-11-20 01:12:11,799 DEBUG : BROWSER_OUTPUT: |2;jquery.html;348.1071052749697;355.0732587945462;359.20794647801597;360.9819509024548;362.7587654209951;10868.945655271733;11184.217104802667;16183.757243641356;17157.48527544174;18361.173747181358;17212.913935430337;17453.7381939271;17489.125543722796;17721.64556708865;17863.464096077107;5645.125005624135;5831.737571809279;5838.241028666289;5839.386864379243;5852.239208902858;5762.193292938992;5907.556933230004;6113.296970848342;6115.541334399915;6116.174316467264;6076.544259180557;6081.270247570298;6099.146119543268;6225.315215326311;6372.076048972896;6284.27730810958;6340.84147896304;6403.391677790602;6413.198350206224;6726.495512836508;6414.230292364946;6451.612903225821;6452.0967064610995;6463.903041454382;6473.546851720382;22121.66817497739;22513.887430562743;22884.65673014906;24022.399440013964;24177.879110604335;2183.5196256823474;2234.6201145805253;2234.8100411465043;2484.7887929526014;2882.1497658190674;13888.4444622215;14398.424063037466;14666.926665366605;14778.408863645442;14969.925150374287;1999.1203870297168;2011.3563659628924;2015.9596808063902;2031.0758604834764;2057.6399130152313;55898;56373.43626563723;56397.71801141009;63226.59413960168;71237.64381178113;15001.32494037771;15583.610409739847;15673;15673.68652626941;15704.528864134094;24421.14525991582;24513;24666.260012199662;24685.87657061703;24735.505289894103;8296.377771667148;8656.913430865736;8724.738257852274;8780.868286975701;8814.338924580683;7389;7398.519096258834;7448.590327532038;7481.663325150382;7494.5128566643;7972.644650409445;8016.519008859487;8028.959855200686;8068.9596552016865;8089.919100809035;1814.7640806695044;3088.3051313454293;3124.173152479425;3136.9728212275263;3184.219866132766;784.9160478928454;912.9041450647719;943.3538026451903;982.2221778580649;991.4844280973854;16230.675386492205;16441;16634.75047874283;16768.664626707643;16881.493555193363;920.7928216151446;922.9492377919279;930.3952430919957;978;1022.0954455306958;9514.47670378122;9674.56464459101;9694.806103877883;9785.36395134314;9870.457124858201;507814;509306;522750;523655;527160;77912.2208777905;79685.60157199293;79787.60106199431;80868.59565702133;81473.18526814655;1077.49357801833;1078.8921107889148;1081.6971248050559;1081.7944590527775;1091.2743025887696;15131.773023404878;15139.318730657367;15172.393104276147;15246.313915874034;15392.384304627689;34580.65419345774;35172.062248254086;35208.82395588108;35907.46138807972;36231.09422264464;42918.57081429146;44179.77910110429;44537;45084;45188.322175168054;8873.556322183995;9380.76548086276;9825;9867.506624668882;9924.603015879573;16532.917335413727;16570.917145414194;17134.629229661346;17468.563285917953;18042.63914721672;14092;14440.350184241524;14450.783238251644;14547.563573092824;14767.483138090116;14187.361568729226;14378.209198494184;14520.85479145195;14718.926405368333;15084.24578771079;15178.468753593572;15249.923750381176;15426.46007389736;15588.298526566105;15731.44939927097;8107.554084525408;8640;8832.602532886163;9033.187013168847;9052.54737263121;9319.906800931903;12460;13169.73660526765;13266.734665306447;14000.36998335057 01:12:11 INFO - 2015-11-20 01:12:11,801 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1449.0436312034055;1452.7457694903392;1542.1980570103547;1643.1948345310802;1654.2969238073815;7579.507332023414;7790.104138024129;7816.1402245753;7831.490953088052;7965.402594805384;7927.40544459165;7967.482113662608;8028.875957365974;8042.879356809653;8051.275385215329;2213.1147540983616;2225.7996780289773;2239.1267405711787;2242.1479837661745;2243.3942835434423;2233.4081468410886;2244.057495851738;2294;2297.322289924476;2299.1033496936125;1948.4836518322586;1971.5761111361055;2218.800307972282;2263.660450932365;2267.206477732797;2198.1317379635034;2226.699395581592;2269.341890851651;2270.557241337948;2271.068861766684;2241.170766816272;2242.4842286274247;2253.5718213539376;2261.5929132756096;2278.851874628144;7705.460617756759;7785.766427007199;7806.687732490694;7811.687532498693;7812.453128281023;4495.14592227479;4608.769561521944;4612.515685852971;4616.261398176276;4629.930551041737;2948.9531216418077;3004.7145521175453;3068.6931306869355;3112.439760843047;3114.6106736657916;954.5847556312957;959.3764053365298;961.8268711631904;970.4613939263705;1015.5430056474615;10556.577736890515;10570.418626975514;10571.78856422875;10600.787984240273;10604.098651614622;3997.9000524986527;4061.89845253871;4095.85664501747;4107;4120.896977575585;8605.65577376898;8610.13898610134;8612.09572994839;8612.311015118776;8640.524771137647;4607.6313894889;4635.6523260755575;4640.187967105743;4659.95340046602;4676.742779147112;4230.111676547898;4266.210751011073;4289.0992891492515;4299;4311.719738217006;3416.8120753358307;3419.093940105874;3426.9143271418416;3431.107911942913;3435.553378060886;1056.3239526702916;1059.777446736194;1066.5307264803462;1069.5080263078914;1070.464767616192;1034.3586976074882;1055.0188324857802;1084.8806631270554;1180.5690922813283;1287.665207046156;7191.532550384313;7220.458465614995;7232.529885557422;7238.529495582876;7266.818329541698;1112.6342812990767;1114.4260705736551;1126.4761885723178;1131.1629394248362;1147.9311241325547;5785.8553536161935;5794.942050579441;5826.883462330729;5838.474537291664;5841.620294680917;8844.425112367675;8883.333749968779;9101.226395756303;9207.815843683089;9279.907200928039;8991.595378207996;9052.50211238375;9092.545372731469;9171.037041110587;9182.72451826433;6780.694868730919;7011.509194356346;7087.7164913402885;7098.893516597255;7205.531640443354;7109.60897150641;7145.285471453021;7184.712611495691;7229.530080544748;7247.420206383371;7697.230276972258;7953.960230198812;8004.279614834692;8173.959130204311;8178.100408955129;8141.8778718320455;8254.298384637133;8274.172582741678;8335.374846886629;8383.496990180609;6830.248672646105;6851.862962740617;7017.087778588955;7024.789256322319;7031.542949708252;7581.393488521016;7591.316781489692;7600.2779735925;7609.695612175451;7620.199879012624;6934.93065069363;7003.614801185984;7020.192677841909;7194.028806111317;7209.206987231505;6798.048273241849;6946.270641582763;7022.40309573692;7031.859362812817;7035.542689725152;6871.381575658214;6891.793246202622;6907.930920690729;6922.688479018356;6925.515213935178;6369.426751592379;6378.1070650108095;6386.297507274103;6400.39196276353;6414;6628.370304821035;6631.602103873783;6650.667466626746;6656.134702488645;6688.097106890702 01:12:11 INFO - 2015-11-20 01:12:11,802 DEBUG : BROWSER_OUTPUT: |4;prototype.html;311.54203321117956;317.6014102301611;322.99192520186995;323.1307782066243;324.1976109129904;6355.459785918197;6374.808755737336;6446.935530644698;6461.483081353498;6530.085787989685;6293.811185664426;6344.555881088326;6362.30014698384;6365.395287447696;6365.458935990447;4577.748223847687;4690.413698287714;4744.383230180072;4783.641226907978;4786.042791441708;4728.101660684459;4734.739589322586;4738.857834264978;4741.834035808747;4766.809327626891;4680.5787479126875;4687.367205427275;4688.554587314216;4690;4706.8352607658735;4691.577758001779;4702.200625893589;4703.694259873115;4712.976435117803;4713.787879545429;3930.0174956260935;3969.384745364473;3991.4212439196444;3994.1013272013856;4057.6550993165615;5922.31893332268;5932.228810254639;5937.376575459558;5937.940620593825;5949.405059494059;5429.891402171974;5481.671099734029;5484.2047903053835;5484.972575137139;5489.423610520877;6570.512020993698;6628.536002479828;6654.500912431587;6675.699593518303;6681.365270299314;4346.978265108654;4359.193549193377;4391.429114215163;4398;4400.823967041314;6877.2091209511045;6911.067005954182;6913.89629155563;6924.723011079551;6942.548734332252;4441.578050085237;4466.575675310905;4470.977645111753;4471.642268618502;4472.038511719931;4454.621357184611;4521.954780452219;4525.275955847049;4538.205813982539;4541.409616749801;5456.345238571397;5461.044317244546;5463.754131064112;5464.480874317013;5471.972640136853;6703.195616525951;6710.261871194165;6719.832004199837;6722.327767223239;6761.391474767196;1626.6421387294777;1645.489898131583;1649.2495914358938;1650.133679818105;1653.6857996980534;1061.2412125330425;1063.1972860490434;1074.382230217628;1087.8096333141668;1092.5192915117323;6454.935450645434;6510.153680021567;6523.478121750249;6537.071563888664;6563.606183628997;6943.132108486439;6946;6952.374286314155;6988.825279368057;6993.2657071006815;6533.673316334164;6571.34286571339;6572.34276572339;6587.440067594212;6595.736170553124;3758.8684396046556;3797.867074652374;3815.96968818423;3823.369144091194;3826.693864490834;7298.6715597797165;7338.22948590401;7355.485116041826;7357.0803649543805;7370.48406611532;7191.712331506786;7208.35124838767;7220.9638951805955;7242.203357630657;7267.345938865422;7155.67799449026;7302.525335853153;7336.413086953031;7349.30181632744;7350.448716346295;6967.233604303624;6976.6860491277;7025.754098606524;7035.577865328097;7050.753223637148;6969.198542167513;6974.721011159497;6974.930250697428;6975.895361569682;6985.336393042653;7189.388901943394;7325.267473252632;7362.153352364332;7370.189279179393;7375.262473752582;4665.2302370108555;4716.622670186445;4724.220503616864;4728.361671174485;4735.100330937111;6891.965540172267;6900.482463815133;6933.7226510939;6954.443644508528;6958.930410696031;6585.209774827052;6725.562838415487;6728.428083612947;6732.899006515004;6743.662816859235;6689.09697190873;6691.799246022627;6707.429868461236;6710.798676039727;6722.983105068362;6402.6158430494315;6552.737890484327;6601.801945941629;6608.207015158212;6615.073889655549;6656.667166641745;6730.360615741497;6747;6760.425363844129;6819.113515242987;6633.402993730588;6651.966740166462;6664.366885145903;6665.466762658879;6678.966605166943 01:12:11 INFO - 2015-11-20 01:12:11,803 DEBUG : BROWSER_OUTPUT: |5;yui.html;796.7251298302084;801.7795106345756;830.5902734810048;849.2993280543553;850.8170743290192;13616.795748063787;13753.587392378246;13758.656033599165;13867.861321386783;13875.236861972588;13038.934805325984;13223.404946777395;13252.403641836116;13263.137896036775;13286.867131328683;794.7019867549669;815.0830315894618;828.457360428917;833.1959658929162;834.5618550261131;808.3815880851154;809.720646376999;813.2802469814197;816.9223923727266;820.1183727492939;860.6686425726109;864.8400045991511;868.7306934850217;869.6695255802786;871.4901782457271;853.15111464093;857.7984173719202;857.9442336248186;861.3109512390125;865.4244927123456;633.1863555331423;637.031711798069;640.3852301790287;640.7821340744123;641.2881701311541;13893.652658683513;13949.442022319095;14048.227347495884;14061.929690351584;14126.646833829236;12163.2702037878;12459.688507787287;12557.811632825424;12562.497500100077;12599.748005039939;10043.849342259871;10052.14556762676;10115.595376184943;10124.746881327952;10212.131968782662;3453.723702103851;3551.4317709166407;3578.928421431583;3639.836207370675;3673.3020726061964;49295;50009.74995125038;50030.499695002945;50705.746471267405;50775.746121269156;9899.802003960025;10077.949610251902;10122.342047767019;10148.340357876714;10169.440680762482;17521;17665.558361041076;17678.204480798395;17685.469435916944;17688.29246830138;7434.442416818761;7565.962170189224;7569.583672898044;7598.0502437195355;7737.767866964;4108.4864391951005;4190.308599081179;4311.07311927937;4344.435223420998;4410.691251612357;3121.7970831895855;3128.9361617050313;3130.201798541357;3132.3265497918055;3185.840707964639;568.6445971267957;577.3908526504578;578.9942100578941;580.756082445374;584.8187062010705;633.3729607688448;671.4997326991422;727.0366764037672;732.7948174511146;742.524784138152;8460.323174146177;8592.613332400057;8791.824163516694;9065.637374505079;9262.16640502358;680.9319068093151;688.3426327856885;690.5683947532792;707.38104158861;709.3367701199292;4122.773247471418;4195.91608167835;4343.9348409773875;4378.824847006148;4557;55417;56144.71927640335;56642;57154.14268785971;57577;49813;50669;50984.74507627438;51512.48487515152;51738.48261517412;45662.315065274044;45757.084858302645;45981;46332.5366746335;46400.767996159804;8685.478871267744;9037.855755742243;9077.364584479023;9106.408083474553;9133.834661603523;35019;35248.295034098664;36173.457398138526;36281.63718362888;36321;40699;43274.567254327056;44861.32708009317;44884;45335.31997019982;11236.055643143918;11372.886271137513;11411.543538258376;11645.359505227294;11761.529538818693;12147.453364598437;12335.876641233473;12451.564195253122;12658.810117848056;13267.66830829237;11307.434628268718;11771.823422648838;11800.232984855957;11966.162368634112;12182.634520964386;11383.715407114889;11952.342621155572;11994;12240.693982650506;12330;11354.716132096764;11372.203945724052;11479.25384849982;11510.94244528772;11779.823302650295;9906.554205060933;9946.086261980772;10035.74910627211;10183.949080254552;10225.795484090426;9217.262618990599;9369.81260374775;9774;9996.200303975518;10049.949750251202 01:12:11 INFO - 2015-11-20 01:12:11,803 DEBUG : BROWSER_OUTPUT: __end_tp_report 01:12:11 INFO - 2015-11-20 01:12:11,803 DEBUG : BROWSER_OUTPUT: __start_cc_report 01:12:11 INFO - 2015-11-20 01:12:11,803 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,276 01:12:11 INFO - 2015-11-20 01:12:11,804 DEBUG : BROWSER_OUTPUT: __end_cc_report 01:12:11 INFO - 2015-11-20 01:12:11,804 DEBUG : BROWSER_OUTPUT: __startTimestamp1448010731792__endTimestamp 01:12:11 INFO - 2015-11-20 01:12:11,804 DEBUG : BROWSER_OUTPUT: 01:12:11 INFO - 2015-11-20 01:12:11,804 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 01:12:11 INFO - 2015-11-20 01:12:11,804 DEBUG : BROWSER_OUTPUT: Number of tests: 6 01:12:11 INFO - 2015-11-20 01:12:11,804 DEBUG : BROWSER_OUTPUT: 01:12:11 INFO - 2015-11-20 01:12:11,804 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:5532.00 Median:5698.72 stddev:599.55 (10.5%) stddev-sans-first:574.15 01:12:11 INFO - 2015-11-20 01:12:11,805 DEBUG : BROWSER_OUTPUT: Values: 3254.6 3334.9 3355.5 3376.2 3381.2 5383.2 5561.5 5572.2 5607.4 5615.9 5510.9 5531.9 5537.5 5633.8 5664.6 5023.5 5067.8 5138.3 5155.9 5164.3 5074.3 5186.9 5224.1 5251.7 5279.0 4895.7 4973.6 5018.5 5089.8 5110.7 5119.8 5122.2 5142.2 5142.9 5150.7 5093.6 5122.5 5132.4 5133.4 5163.4 5195.2 5224.6 5308.7 5312.6 5316.0 5866.8 5876.7 5877.6 5882.1 5883.5 5781.5 5920.1 5927.2 5948.2 5972.0 5518.4 5584.4 5588.0 5639.7 5657.1 6041.8 6051.5 6060.1 6101.8 6106.4 5737.3 5816.3 5851.6 5905.3 5932.7 5932.5 6003.5 6016.3 6017.8 6022.0 5926.1 6021.9 6064.4 6065.0 6068.9 5782.2 5910.9 5918.6 5991.7 6073.8 4580.5 4644.2 4645.1 4671.0 4686.4 4093.1 4121.4 4128.1 4143.5 4170.9 5420.1 5548.8 5549.6 5654.3 5698.7 5882.8 5892.8 5896.4 5898.1 6060.0 5558.8 5565.1 5569.9 5570.4 5596.5 5056.3 5171.8 5185.4 5230.4 5244.1 6045.1 6099.2 6129.0 6133.5 6142.6 5796.7 5865.5 5867.7 5873.6 5899.4 6104.1 6134.0 6218.5 6228.4 6232.3 5822.2 5951.8 6014.6 6019.3 6026.8 5707.2 5835.8 6016.3 6108.2 6112.4 5788.6 5841.3 5857.2 5857.6 5924.4 5901.5 5919.8 5931.3 5937.4 5938.5 5444.6 5491.2 5608.3 5851.3 5860.1 5753.1 5781.6 5783.2 5790.8 5798.1 5596.8 5633.7 5645.9 5654.2 5671.3 01:12:11 INFO - 2015-11-20 01:12:11,805 DEBUG : BROWSER_OUTPUT: 01:12:11 INFO - 2015-11-20 01:12:11,806 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:45184.03 Median:36349.91 stddev:74150.45 (204.0%) stddev-sans-first:74282.83 01:12:11 INFO - 2015-11-20 01:12:11,806 DEBUG : BROWSER_OUTPUT: Values: 578.6 591.7 593.2 595.3 595.4 30499.4 38977.8 39817.0 39888.6 39966.6 43233.4 43356.1 43406.0 43626.3 43678.8 8620.7 8716.7 8745.9 8818.9 8856.9 8566.3 8691.8 8703.8 8720.9 8755.9 8599.0 8637.1 8711.7 8718.0 8718.5 8795.9 8812.2 8834.1 8867.8 8885.4 8636.8 8712.8 8736.4 8787.8 8789.0 39967.6 40185.4 40263.8 40267.0 40569.0 3300.4 3374.5 3470.1 3567.7 3650.9 29554.6 30278.7 30340.1 30351.1 30603.8 3889.4 3916.8 4042.4 4050.1 4089.3 269820.0 269895.0 270521.0 270555.0 271134.0 55309.7 56620.7 58244.7 59329.7 59375.4 54723.0 54732.5 54821.7 54874.5 55018.4 15683.9 15838.4 15882.3 15913.8 15940.1 10379.6 10391.7 10521.5 10521.8 10529.2 19108.0 19425.6 19487.0 19634.3 19722.1 7584.2 7671.7 7687.6 7764.8 7792.2 859.9 943.5 943.9 1004.7 1147.1 27652.4 28407.4 28612.0 28630.4 28895.0 981.9 990.3 1055.7 1085.3 1116.6 14713.6 14946.3 15026.2 15125.2 15136.5 313173.0 316134.0 316354.0 317651.0 318757.0 51082.2 51173.0 51271.7 51375.7 51607.7 1313.4 1331.5 1337.8 1343.9 1347.1 27064.7 27369.0 28088.7 28518.1 28886.9 42749.6 43021.8 43277.4 43298.9 43345.6 261712.0 262825.0 262939.0 263229.0 263317.0 30550.4 31421.5 32024.2 32188.8 32264.5 42567.5 42628.6 43914.6 43915.3 44462.8 32984.2 35834.3 36171.5 36191.6 36555.6 35429.5 36229.8 36470.0 36516.3 36872.3 33307.3 33498.0 33927.7 35246.3 35428.8 30893.5 31865.4 32143.8 32884.3 32896.8 24020.4 24718.1 24896.6 24933.3 25069.9 01:12:11 INFO - 2015-11-20 01:12:11,806 DEBUG : BROWSER_OUTPUT: 01:12:11 INFO - 2015-11-20 01:12:11,806 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:29114.48 Median:18133.33 stddev:84523.23 (466.1%) stddev-sans-first:84732.74 01:12:11 INFO - 2015-11-20 01:12:11,808 DEBUG : BROWSER_OUTPUT: Values: 348.1 355.1 359.2 361.0 362.8 10868.9 11184.2 16183.8 17157.5 18361.2 17212.9 17453.7 17489.1 17721.6 17863.5 5645.1 5831.7 5838.2 5839.4 5852.2 5762.2 5907.6 6113.3 6115.5 6116.2 6076.5 6081.3 6099.1 6225.3 6372.1 6284.3 6340.8 6403.4 6413.2 6726.5 6414.2 6451.6 6452.1 6463.9 6473.5 22121.7 22513.9 22884.7 24022.4 24177.9 2183.5 2234.6 2234.8 2484.8 2882.1 13888.4 14398.4 14666.9 14778.4 14969.9 1999.1 2011.4 2016.0 2031.1 2057.6 55898.0 56373.4 56397.7 63226.6 71237.6 15001.3 15583.6 15673.0 15673.7 15704.5 24421.1 24513.0 24666.3 24685.9 24735.5 8296.4 8656.9 8724.7 8780.9 8814.3 7389.0 7398.5 7448.6 7481.7 7494.5 7972.6 8016.5 8029.0 8069.0 8089.9 1814.8 3088.3 3124.2 3137.0 3184.2 784.9 912.9 943.4 982.2 991.5 16230.7 16441.0 16634.8 16768.7 16881.5 920.8 922.9 930.4 978.0 1022.1 9514.5 9674.6 9694.8 9785.4 9870.5 507814.0 509306.0 522750.0 523655.0 527160.0 77912.2 79685.6 79787.6 80868.6 81473.2 1077.5 1078.9 1081.7 1081.8 1091.3 15131.8 15139.3 15172.4 15246.3 15392.4 34580.7 35172.1 35208.8 35907.5 36231.1 42918.6 44179.8 44537.0 45084.0 45188.3 8873.6 9380.8 9825.0 9867.5 9924.6 16532.9 16570.9 17134.6 17468.6 18042.6 14092.0 14440.4 14450.8 14547.6 14767.5 14187.4 14378.2 14520.9 14718.9 15084.2 15178.5 15249.9 15426.5 15588.3 15731.4 8107.6 8640.0 8832.6 9033.2 9052.5 9319.9 12460.0 13169.7 13266.7 14000.4 01:12:11 INFO - 2015-11-20 01:12:11,808 DEBUG : BROWSER_OUTPUT: 01:12:11 INFO - 2015-11-20 01:12:11,808 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5391.02 Median:6521.19 stddev:2787.22 (42.7%) stddev-sans-first:2779.29 01:12:11 INFO - 2015-11-20 01:12:11,808 DEBUG : BROWSER_OUTPUT: Values: 1449.0 1452.7 1542.2 1643.2 1654.3 7579.5 7790.1 7816.1 7831.5 7965.4 7927.4 7967.5 8028.9 8042.9 8051.3 2213.1 2225.8 2239.1 2242.1 2243.4 2233.4 2244.1 2294.0 2297.3 2299.1 1948.5 1971.6 2218.8 2263.7 2267.2 2198.1 2226.7 2269.3 2270.6 2271.1 2241.2 2242.5 2253.6 2261.6 2278.9 7705.5 7785.8 7806.7 7811.7 7812.5 4495.1 4608.8 4612.5 4616.3 4629.9 2949.0 3004.7 3068.7 3112.4 3114.6 954.6 959.4 961.8 970.5 1015.5 10556.6 10570.4 10571.8 10600.8 10604.1 3997.9 4061.9 4095.9 4107.0 4120.9 8605.7 8610.1 8612.1 8612.3 8640.5 4607.6 4635.7 4640.2 4660.0 4676.7 4230.1 4266.2 4289.1 4299.0 4311.7 3416.8 3419.1 3426.9 3431.1 3435.6 1056.3 1059.8 1066.5 1069.5 1070.5 1034.4 1055.0 1084.9 1180.6 1287.7 7191.5 7220.5 7232.5 7238.5 7266.8 1112.6 1114.4 1126.5 1131.2 1147.9 5785.9 5794.9 5826.9 5838.5 5841.6 8844.4 8883.3 9101.2 9207.8 9279.9 8991.6 9052.5 9092.5 9171.0 9182.7 6780.7 7011.5 7087.7 7098.9 7205.5 7109.6 7145.3 7184.7 7229.5 7247.4 7697.2 7954.0 8004.3 8174.0 8178.1 8141.9 8254.3 8274.2 8335.4 8383.5 6830.2 6851.9 7017.1 7024.8 7031.5 7581.4 7591.3 7600.3 7609.7 7620.2 6934.9 7003.6 7020.2 7194.0 7209.2 6798.0 6946.3 7022.4 7031.9 7035.5 6871.4 6891.8 6907.9 6922.7 6925.5 6369.4 6378.1 6386.3 6400.4 6414.0 6628.4 6631.6 6650.7 6656.1 6688.1 01:12:11 INFO - 2015-11-20 01:12:11,808 DEBUG : BROWSER_OUTPUT: 01:12:11 INFO - 2015-11-20 01:12:11,808 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:5589.53 Median:6485.82 stddev:1751.56 (27.0%) stddev-sans-first:1711.09 01:12:11 INFO - 2015-11-20 01:12:11,809 DEBUG : BROWSER_OUTPUT: Values: 311.5 317.6 323.0 323.1 324.2 6355.5 6374.8 6446.9 6461.5 6530.1 6293.8 6344.6 6362.3 6365.4 6365.5 4577.7 4690.4 4744.4 4783.6 4786.0 4728.1 4734.7 4738.9 4741.8 4766.8 4680.6 4687.4 4688.6 4690.0 4706.8 4691.6 4702.2 4703.7 4713.0 4713.8 3930.0 3969.4 3991.4 3994.1 4057.7 5922.3 5932.2 5937.4 5937.9 5949.4 5429.9 5481.7 5484.2 5485.0 5489.4 6570.5 6628.5 6654.5 6675.7 6681.4 4347.0 4359.2 4391.4 4398.0 4400.8 6877.2 6911.1 6913.9 6924.7 6942.5 4441.6 4466.6 4471.0 4471.6 4472.0 4454.6 4522.0 4525.3 4538.2 4541.4 5456.3 5461.0 5463.8 5464.5 5472.0 6703.2 6710.3 6719.8 6722.3 6761.4 1626.6 1645.5 1649.2 1650.1 1653.7 1061.2 1063.2 1074.4 1087.8 1092.5 6454.9 6510.2 6523.5 6537.1 6563.6 6943.1 6946.0 6952.4 6988.8 6993.3 6533.7 6571.3 6572.3 6587.4 6595.7 3758.9 3797.9 3816.0 3823.4 3826.7 7298.7 7338.2 7355.5 7357.1 7370.5 7191.7 7208.4 7221.0 7242.2 7267.3 7155.7 7302.5 7336.4 7349.3 7350.4 6967.2 6976.7 7025.8 7035.6 7050.8 6969.2 6974.7 6974.9 6975.9 6985.3 7189.4 7325.3 7362.2 7370.2 7375.3 4665.2 4716.6 4724.2 4728.4 4735.1 6892.0 6900.5 6933.7 6954.4 6958.9 6585.2 6725.6 6728.4 6732.9 6743.7 6689.1 6691.8 6707.4 6710.8 6723.0 6402.6 6552.7 6601.8 6608.2 6615.1 6656.7 6730.4 6747.0 6760.4 6819.1 6633.4 6652.0 6664.4 6665.5 6679.0 01:12:11 INFO - 2015-11-20 01:12:11,810 DEBUG : BROWSER_OUTPUT: 01:12:11 INFO - 2015-11-20 01:12:11,810 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:13924.26 Median:45109.66 stddev:15919.16 (35.3%) stddev-sans-first:15933.29 01:12:11 INFO - 2015-11-20 01:12:11,811 DEBUG : BROWSER_OUTPUT: Values: 796.7 801.8 830.6 849.3 850.8 13616.8 13753.6 13758.7 13867.9 13875.2 13038.9 13223.4 13252.4 13263.1 13286.9 794.7 815.1 828.5 833.2 834.6 808.4 809.7 813.3 816.9 820.1 860.7 864.8 868.7 869.7 871.5 853.2 857.8 857.9 861.3 865.4 633.2 637.0 640.4 640.8 641.3 13893.7 13949.4 14048.2 14061.9 14126.6 12163.3 12459.7 12557.8 12562.5 12599.7 10043.8 10052.1 10115.6 10124.7 10212.1 3453.7 3551.4 3578.9 3639.8 3673.3 49295.0 50009.7 50030.5 50705.7 50775.7 9899.8 10077.9 10122.3 10148.3 10169.4 17521.0 17665.6 17678.2 17685.5 17688.3 7434.4 7566.0 7569.6 7598.1 7737.8 4108.5 4190.3 4311.1 4344.4 4410.7 3121.8 3128.9 3130.2 3132.3 3185.8 568.6 577.4 579.0 580.8 584.8 633.4 671.5 727.0 732.8 742.5 8460.3 8592.6 8791.8 9065.6 9262.2 680.9 688.3 690.6 707.4 709.3 4122.8 4195.9 4343.9 4378.8 4557.0 55417.0 56144.7 56642.0 57154.1 57577.0 49813.0 50669.0 50984.7 51512.5 51738.5 45662.3 45757.1 45981.0 46332.5 46400.8 8685.5 9037.9 9077.4 9106.4 9133.8 35019.0 35248.3 36173.5 36281.6 36321.0 40699.0 43274.6 44861.3 44884.0 45335.3 11236.1 11372.9 11411.5 11645.4 11761.5 12147.5 12335.9 12451.6 12658.8 13267.7 11307.4 11771.8 11800.2 11966.2 12182.6 11383.7 11952.3 11994.0 12240.7 12330.0 11354.7 11372.2 11479.3 11510.9 11779.8 9906.6 9946.1 10035.7 10183.9 10225.8 9217.3 9369.8 9774.0 9996.2 10049.9 01:12:11 INFO - 2015-11-20 01:12:11,811 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 01:12:11 INFO - 2015-11-20 01:12:11,811 DEBUG : BROWSER_OUTPUT: 01:12:12 INFO - 2015-11-20 01:12:12,477 INFO : Browser exited with error code: 0 01:12:12 INFO - 2015-11-20 01:12:12,501 INFO : Completed test dromaeo_css (00:18:30) 01:12:12 INFO - 2015-11-20 01:12:12,501 INFO : Starting test kraken 01:12:12 INFO - 2015-11-20 01:12:12,501 DEBUG : operating with platform_type : linux_ 01:12:12 INFO - 2015-11-20 01:12:12,501 INFO : Initialising browser for kraken test... 01:12:12 INFO - 2015-11-20 01:12:12,507 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpZFtN5Y/profile http://localhost:40862/getInfo.html 01:12:17 INFO - 2015-11-20 01:12:17,186 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 01:12:17 INFO - 2015-11-20 01:12:17,186 DEBUG : BROWSER_OUTPUT: colorDepth:24 01:12:17 INFO - 2015-11-20 01:12:17,186 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 01:12:17 INFO - 2015-11-20 01:12:17,187 DEBUG : BROWSER_OUTPUT: __metrics 01:12:18 INFO - 2015-11-20 01:12:18,193 INFO : Browser initialized. 01:12:18 INFO - 2015-11-20 01:12:18,194 INFO : Running cycle 1/1 for kraken test... 01:12:18 INFO - 2015-11-20 01:12:18,194 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpZFtN5Y/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 01:12:29 INFO - 2015-11-20 01:12:29,925 DEBUG : BROWSER_OUTPUT: RSS: Main: 141815808 01:12:29 INFO - 2015-11-20 01:12:29,925 DEBUG : BROWSER_OUTPUT: 01:12:32 INFO - 2015-11-20 01:12:32,403 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40862/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:40862/tests/kraken/driver.html?testName=audio-beat-detection) 01:12:33 INFO - 2015-11-20 01:12:33,004 DEBUG : BROWSER_OUTPUT: RSS: Main: 141824000 01:12:33 INFO - 2015-11-20 01:12:33,004 DEBUG : BROWSER_OUTPUT: 01:12:35 INFO - 2015-11-20 01:12:35,646 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40862/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:40862/tests/kraken/driver.html?testName=audio-dft) 01:12:36 INFO - 2015-11-20 01:12:36,240 DEBUG : BROWSER_OUTPUT: RSS: Main: 142389248 01:12:36 INFO - 2015-11-20 01:12:36,240 DEBUG : BROWSER_OUTPUT: 01:12:39 INFO - 2015-11-20 01:12:39,082 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40862/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:40862/tests/kraken/driver.html?testName=audio-fft) 01:12:39 INFO - 2015-11-20 01:12:39,655 DEBUG : BROWSER_OUTPUT: RSS: Main: 137326592 01:12:39 INFO - 2015-11-20 01:12:39,655 DEBUG : BROWSER_OUTPUT: 01:12:41 INFO - 2015-11-20 01:12:41,647 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40862/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:40862/tests/kraken/driver.html?testName=audio-oscillator) 01:12:42 INFO - 2015-11-20 01:12:42,228 DEBUG : BROWSER_OUTPUT: RSS: Main: 137097216 01:12:42 INFO - 2015-11-20 01:12:42,229 DEBUG : BROWSER_OUTPUT: 01:12:44 INFO - 2015-11-20 01:12:44,410 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40862/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:40862/tests/kraken/driver.html?testName=imaging-gaussian-blur) 01:12:44 INFO - 2015-11-20 01:12:44,991 DEBUG : BROWSER_OUTPUT: RSS: Main: 137596928 01:12:44 INFO - 2015-11-20 01:12:44,991 DEBUG : BROWSER_OUTPUT: 01:12:47 INFO - 2015-11-20 01:12:47,975 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40862/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:40862/tests/kraken/driver.html?testName=imaging-darkroom) 01:12:48 INFO - 2015-11-20 01:12:48,562 DEBUG : BROWSER_OUTPUT: RSS: Main: 137768960 01:12:48 INFO - 2015-11-20 01:12:48,562 DEBUG : BROWSER_OUTPUT: 01:12:51 INFO - 2015-11-20 01:12:51,996 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40862/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:40862/tests/kraken/driver.html?testName=imaging-desaturate) 01:12:52 INFO - 2015-11-20 01:12:52,583 DEBUG : BROWSER_OUTPUT: RSS: Main: 139223040 01:12:52 INFO - 2015-11-20 01:12:52,583 DEBUG : BROWSER_OUTPUT: 01:12:55 INFO - 2015-11-20 01:12:55,368 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40862/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:40862/tests/kraken/driver.html?testName=json-parse-financial) 01:12:55 INFO - 2015-11-20 01:12:55,976 DEBUG : BROWSER_OUTPUT: RSS: Main: 139423744 01:12:55 INFO - 2015-11-20 01:12:55,976 DEBUG : BROWSER_OUTPUT: 01:12:57 INFO - 2015-11-20 01:12:57,564 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40862/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:40862/tests/kraken/driver.html?testName=json-stringify-tinderbox) 01:12:58 INFO - 2015-11-20 01:12:58,146 DEBUG : BROWSER_OUTPUT: RSS: Main: 139866112 01:12:58 INFO - 2015-11-20 01:12:58,146 DEBUG : BROWSER_OUTPUT: 01:12:59 INFO - 2015-11-20 01:12:59,981 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40862/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:40862/tests/kraken/driver.html?testName=stanford-crypto-aes) 01:13:00 INFO - 2015-11-20 01:13:00,594 DEBUG : BROWSER_OUTPUT: RSS: Main: 140070912 01:13:00 INFO - 2015-11-20 01:13:00,595 DEBUG : BROWSER_OUTPUT: 01:13:02 INFO - 2015-11-20 01:13:02,718 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40862/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:40862/tests/kraken/driver.html?testName=stanford-crypto-ccm) 01:13:03 INFO - 2015-11-20 01:13:03,304 DEBUG : BROWSER_OUTPUT: RSS: Main: 139866112 01:13:03 INFO - 2015-11-20 01:13:03,304 DEBUG : BROWSER_OUTPUT: 01:13:05 INFO - 2015-11-20 01:13:05,784 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40862/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:40862/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 01:13:06 INFO - 2015-11-20 01:13:06,385 DEBUG : BROWSER_OUTPUT: RSS: Main: 140316672 01:13:06 INFO - 2015-11-20 01:13:06,386 DEBUG : BROWSER_OUTPUT: 01:13:08 INFO - 2015-11-20 01:13:08,988 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40862/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:40862/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 01:13:09 INFO - 2015-11-20 01:13:09,573 DEBUG : BROWSER_OUTPUT: RSS: Main: 140165120 01:13:09 INFO - 2015-11-20 01:13:09,573 DEBUG : BROWSER_OUTPUT: 01:13:11 INFO - 2015-11-20 01:13:11,242 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40862/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:40862/tests/kraken/driver.html?testName=ai-astar) 01:13:11 INFO - 2015-11-20 01:13:11,486 DEBUG : BROWSER_OUTPUT: RSS: Main: 140935168 01:13:11 INFO - 2015-11-20 01:13:11,486 DEBUG : BROWSER_OUTPUT: 01:13:11 INFO - 2015-11-20 01:13:11,488 DEBUG : BROWSER_OUTPUT: __start_tp_report 01:13:11 INFO - 2015-11-20 01:13:11,488 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 01:13:11 INFO - 2015-11-20 01:13:11,488 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 01:13:11 INFO - 2015-11-20 01:13:11,488 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 01:13:11 INFO - 2015-11-20 01:13:11,488 DEBUG : BROWSER_OUTPUT: |0;ai-astar;111;105;110;112;111;122;110;109;110;110 01:13:11 INFO - 2015-11-20 01:13:11,490 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;154;127;158;158;124;152;156;126;165;125 01:13:11 INFO - 2015-11-20 01:13:11,490 DEBUG : BROWSER_OUTPUT: |2;audio-dft;163;163;160;161;162;161;160;163;176;161 01:13:11 INFO - 2015-11-20 01:13:11,490 DEBUG : BROWSER_OUTPUT: |3;audio-fft;73;74;73;72;74;72;73;72;132;74 01:13:11 INFO - 2015-11-20 01:13:11,490 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;93;91;130;91;90;91;132;91;90;142 01:13:11 INFO - 2015-11-20 01:13:11,490 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;110;109;109;110;110;109;109;110;110;110 01:13:11 INFO - 2015-11-20 01:13:11,490 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;150;146;147;148;147;146;147;146;148;148 01:13:11 INFO - 2015-11-20 01:13:11,490 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;97;96;96;96;96;96;97;96;95;96 01:13:11 INFO - 2015-11-20 01:13:11,490 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;63;64;63;63;62;63;62;62;60;59 01:13:11 INFO - 2015-11-20 01:13:11,490 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;70;69;68;70;69;70;69;69;70;69 01:13:11 INFO - 2015-11-20 01:13:11,490 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;91;92;84;86;93;85;84;86;94;85 01:13:11 INFO - 2015-11-20 01:13:11,490 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;122;129;121;119;131;135;126;128;120;119 01:13:11 INFO - 2015-11-20 01:13:11,491 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;148;151;152;167;153;152;151;152;158;141 01:13:11 INFO - 2015-11-20 01:13:11,491 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;71;67;68;69;69;71;67;66;69;66 01:13:11 INFO - 2015-11-20 01:13:11,491 DEBUG : BROWSER_OUTPUT: __end_tp_report 01:13:11 INFO - 2015-11-20 01:13:11,491 DEBUG : BROWSER_OUTPUT: __start_cc_report 01:13:11 INFO - 2015-11-20 01:13:11,491 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,728 01:13:11 INFO - 2015-11-20 01:13:11,491 DEBUG : BROWSER_OUTPUT: __end_cc_report 01:13:11 INFO - 2015-11-20 01:13:11,491 DEBUG : BROWSER_OUTPUT: __startTimestamp1448010791487__endTimestamp 01:13:11 INFO - 2015-11-20 01:13:11,491 DEBUG : BROWSER_OUTPUT: 01:13:11 INFO - 2015-11-20 01:13:11,492 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 01:13:11 INFO - 2015-11-20 01:13:11,492 DEBUG : BROWSER_OUTPUT: Number of tests: 14 01:13:11 INFO - 2015-11-20 01:13:11,492 DEBUG : BROWSER_OUTPUT: 01:13:11 INFO - 2015-11-20 01:13:11,492 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:111.00 Median:110.50 stddev:4.29 (3.9%) stddev-sans-first:4.56 01:13:11 INFO - 2015-11-20 01:13:11,492 DEBUG : BROWSER_OUTPUT: Values: 111.0 105.0 110.0 112.0 111.0 122.0 110.0 109.0 110.0 110.0 01:13:11 INFO - 2015-11-20 01:13:11,493 DEBUG : BROWSER_OUTPUT: 01:13:11 INFO - 2015-11-20 01:13:11,493 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:144.50 Median:155.00 stddev:16.71 (10.8%) stddev-sans-first:17.36 01:13:11 INFO - 2015-11-20 01:13:11,493 DEBUG : BROWSER_OUTPUT: Values: 154.0 127.0 158.0 158.0 124.0 152.0 156.0 126.0 165.0 125.0 01:13:11 INFO - 2015-11-20 01:13:11,493 DEBUG : BROWSER_OUTPUT: 01:13:11 INFO - 2015-11-20 01:13:11,493 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:163.00 Median:162.50 stddev:4.71 (2.9%) stddev-sans-first:5.00 01:13:11 INFO - 2015-11-20 01:13:11,493 DEBUG : BROWSER_OUTPUT: Values: 163.0 163.0 160.0 161.0 162.0 161.0 160.0 163.0 176.0 161.0 01:13:11 INFO - 2015-11-20 01:13:11,493 DEBUG : BROWSER_OUTPUT: 01:13:11 INFO - 2015-11-20 01:13:11,493 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:78.90 Median:73.00 stddev:18.68 (25.6%) stddev-sans-first:19.69 01:13:11 INFO - 2015-11-20 01:13:11,493 DEBUG : BROWSER_OUTPUT: Values: 73.0 74.0 73.0 72.0 74.0 72.0 73.0 72.0 132.0 74.0 01:13:11 INFO - 2015-11-20 01:13:11,494 DEBUG : BROWSER_OUTPUT: 01:13:11 INFO - 2015-11-20 01:13:11,494 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:104.10 Median:91.00 stddev:21.33 (23.4%) stddev-sans-first:22.24 01:13:11 INFO - 2015-11-20 01:13:11,494 DEBUG : BROWSER_OUTPUT: Values: 93.0 91.0 130.0 91.0 90.0 91.0 132.0 91.0 90.0 142.0 01:13:11 INFO - 2015-11-20 01:13:11,494 DEBUG : BROWSER_OUTPUT: 01:13:11 INFO - 2015-11-20 01:13:11,494 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:109.60 Median:110.00 stddev:0.52 (0.5%) stddev-sans-first:0.53 01:13:11 INFO - 2015-11-20 01:13:11,494 DEBUG : BROWSER_OUTPUT: Values: 110.0 109.0 109.0 110.0 110.0 109.0 109.0 110.0 110.0 110.0 01:13:11 INFO - 2015-11-20 01:13:11,494 DEBUG : BROWSER_OUTPUT: 01:13:11 INFO - 2015-11-20 01:13:11,494 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:147.30 Median:147.50 stddev:1.25 (0.8%) stddev-sans-first:0.87 01:13:11 INFO - 2015-11-20 01:13:11,494 DEBUG : BROWSER_OUTPUT: Values: 150.0 146.0 147.0 148.0 147.0 146.0 147.0 146.0 148.0 148.0 01:13:11 INFO - 2015-11-20 01:13:11,494 DEBUG : BROWSER_OUTPUT: 01:13:11 INFO - 2015-11-20 01:13:11,494 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:96.10 Median:96.00 stddev:0.57 (0.6%) stddev-sans-first:0.50 01:13:11 INFO - 2015-11-20 01:13:11,495 DEBUG : BROWSER_OUTPUT: Values: 97.0 96.0 96.0 96.0 96.0 96.0 97.0 96.0 95.0 96.0 01:13:11 INFO - 2015-11-20 01:13:11,495 DEBUG : BROWSER_OUTPUT: 01:13:11 INFO - 2015-11-20 01:13:11,495 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:62.10 Median:63.00 stddev:1.52 (2.4%) stddev-sans-first:1.58 01:13:11 INFO - 2015-11-20 01:13:11,495 DEBUG : BROWSER_OUTPUT: Values: 63.0 64.0 63.0 63.0 62.0 63.0 62.0 62.0 60.0 59.0 01:13:11 INFO - 2015-11-20 01:13:11,495 DEBUG : BROWSER_OUTPUT: 01:13:11 INFO - 2015-11-20 01:13:11,495 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:69.30 Median:69.50 stddev:0.67 (1.0%) stddev-sans-first:0.67 01:13:11 INFO - 2015-11-20 01:13:11,495 DEBUG : BROWSER_OUTPUT: Values: 70.0 69.0 68.0 70.0 69.0 70.0 69.0 69.0 70.0 69.0 01:13:11 INFO - 2015-11-20 01:13:11,495 DEBUG : BROWSER_OUTPUT: 01:13:11 INFO - 2015-11-20 01:13:11,495 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:88.00 Median:88.50 stddev:4.00 (4.5%) stddev-sans-first:4.09 01:13:11 INFO - 2015-11-20 01:13:11,495 DEBUG : BROWSER_OUTPUT: Values: 91.0 92.0 84.0 86.0 93.0 85.0 84.0 86.0 94.0 85.0 01:13:11 INFO - 2015-11-20 01:13:11,496 DEBUG : BROWSER_OUTPUT: 01:13:11 INFO - 2015-11-20 01:13:11,496 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:125.00 Median:127.00 stddev:5.62 (4.4%) stddev-sans-first:5.85 01:13:11 INFO - 2015-11-20 01:13:11,496 DEBUG : BROWSER_OUTPUT: Values: 122.0 129.0 121.0 119.0 131.0 135.0 126.0 128.0 120.0 119.0 01:13:11 INFO - 2015-11-20 01:13:11,496 DEBUG : BROWSER_OUTPUT: 01:13:11 INFO - 2015-11-20 01:13:11,496 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:152.50 Median:152.00 stddev:6.65 (4.4%) stddev-sans-first:6.86 01:13:11 INFO - 2015-11-20 01:13:11,496 DEBUG : BROWSER_OUTPUT: Values: 148.0 151.0 152.0 167.0 153.0 152.0 151.0 152.0 158.0 141.0 01:13:11 INFO - 2015-11-20 01:13:11,496 DEBUG : BROWSER_OUTPUT: 01:13:11 INFO - 2015-11-20 01:13:11,497 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.30 Median:69.00 stddev:1.83 (2.7%) stddev-sans-first:1.66 01:13:11 INFO - 2015-11-20 01:13:11,497 DEBUG : BROWSER_OUTPUT: Values: 71.0 67.0 68.0 69.0 69.0 71.0 67.0 66.0 69.0 66.0 01:13:11 INFO - 2015-11-20 01:13:11,497 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 01:13:11 INFO - 2015-11-20 01:13:11,497 DEBUG : BROWSER_OUTPUT: 01:13:12 INFO - 2015-11-20 01:13:12,473 INFO : Browser exited with error code: 0 01:13:12 INFO - 2015-11-20 01:13:12,523 INFO : Completed test kraken (00:01:00) 01:13:12 INFO - 2015-11-20 01:13:12,523 INFO : Starting test v8_7 01:13:12 INFO - 2015-11-20 01:13:12,523 DEBUG : operating with platform_type : linux_ 01:13:12 INFO - 2015-11-20 01:13:12,524 INFO : Initialising browser for v8_7 test... 01:13:12 INFO - 2015-11-20 01:13:12,530 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpqYR3pO/profile http://localhost:40862/getInfo.html 01:13:17 INFO - 2015-11-20 01:13:17,042 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 01:13:17 INFO - 2015-11-20 01:13:17,042 DEBUG : BROWSER_OUTPUT: colorDepth:24 01:13:17 INFO - 2015-11-20 01:13:17,043 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 01:13:17 INFO - 2015-11-20 01:13:17,043 DEBUG : BROWSER_OUTPUT: __metrics 01:13:18 INFO - 2015-11-20 01:13:18,105 INFO : Browser initialized. 01:13:18 INFO - 2015-11-20 01:13:18,106 INFO : Running cycle 1/1 for v8_7 test... 01:13:18 INFO - 2015-11-20 01:13:18,106 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpqYR3pO/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 01:13:29 INFO - 2015-11-20 01:13:29,946 DEBUG : BROWSER_OUTPUT: RSS: Main: 142360576 01:13:29 INFO - 2015-11-20 01:13:29,946 DEBUG : BROWSER_OUTPUT: 01:13:51 INFO - 2015-11-20 01:13:51,364 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40862/tests/v8_7/run.html (next: http://localhost:40862/tests/v8_7/run.html) 01:13:51 INFO - 2015-11-20 01:13:51,622 DEBUG : BROWSER_OUTPUT: RSS: Main: 139145216 01:13:51 INFO - 2015-11-20 01:13:51,622 DEBUG : BROWSER_OUTPUT: 01:13:51 INFO - 2015-11-20 01:13:51,623 DEBUG : BROWSER_OUTPUT: __start_tp_report 01:13:51 INFO - 2015-11-20 01:13:51,623 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 01:13:51 INFO - 2015-11-20 01:13:51,623 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 01:13:51 INFO - 2015-11-20 01:13:51,623 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 01:13:51 INFO - 2015-11-20 01:13:51,623 DEBUG : BROWSER_OUTPUT: |0;Richards;165.59032952475576 01:13:51 INFO - 2015-11-20 01:13:51,623 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;192.3816852635629 01:13:51 INFO - 2015-11-20 01:13:51,623 DEBUG : BROWSER_OUTPUT: |2;Encrypt;281.5315315315315 01:13:51 INFO - 2015-11-20 01:13:51,624 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5045.226130653266 01:13:51 INFO - 2015-11-20 01:13:51,624 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1058.2010582010582 01:13:51 INFO - 2015-11-20 01:13:51,624 DEBUG : BROWSER_OUTPUT: |5;Earley;695.8942240779402 01:13:51 INFO - 2015-11-20 01:13:51,624 DEBUG : BROWSER_OUTPUT: |6;Boyer;12011.904761904761 01:13:51 INFO - 2015-11-20 01:13:51,624 DEBUG : BROWSER_OUTPUT: |7;RegExp;25575 01:13:51 INFO - 2015-11-20 01:13:51,624 DEBUG : BROWSER_OUTPUT: |8;Splay;633.7135614702155 01:13:51 INFO - 2015-11-20 01:13:51,624 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4850.241545893719 01:13:51 INFO - 2015-11-20 01:13:51,624 DEBUG : BROWSER_OUTPUT: __end_tp_report 01:13:51 INFO - 2015-11-20 01:13:51,625 DEBUG : BROWSER_OUTPUT: __startTimestamp1448010831615__endTimestamp 01:13:51 INFO - 2015-11-20 01:13:51,625 DEBUG : BROWSER_OUTPUT: 01:13:51 INFO - 2015-11-20 01:13:51,625 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 01:13:51 INFO - 2015-11-20 01:13:51,625 DEBUG : BROWSER_OUTPUT: Number of tests: 10 01:13:51 INFO - 2015-11-20 01:13:51,625 DEBUG : BROWSER_OUTPUT: 01:13:51 INFO - 2015-11-20 01:13:51,625 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:165.59 Median:165.59 stddev:0.00 (0.0%) 01:13:51 INFO - 2015-11-20 01:13:51,625 DEBUG : BROWSER_OUTPUT: Values: 165.6 01:13:51 INFO - 2015-11-20 01:13:51,626 DEBUG : BROWSER_OUTPUT: 01:13:51 INFO - 2015-11-20 01:13:51,626 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:192.38 Median:192.38 stddev:0.00 (0.0%) 01:13:51 INFO - 2015-11-20 01:13:51,626 DEBUG : BROWSER_OUTPUT: Values: 192.4 01:13:51 INFO - 2015-11-20 01:13:51,626 DEBUG : BROWSER_OUTPUT: 01:13:51 INFO - 2015-11-20 01:13:51,626 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:281.53 Median:281.53 stddev:0.00 (0.0%) 01:13:51 INFO - 2015-11-20 01:13:51,626 DEBUG : BROWSER_OUTPUT: Values: 281.5 01:13:51 INFO - 2015-11-20 01:13:51,626 DEBUG : BROWSER_OUTPUT: 01:13:51 INFO - 2015-11-20 01:13:51,626 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5045.23 Median:5045.23 stddev:0.00 (0.0%) 01:13:51 INFO - 2015-11-20 01:13:51,627 DEBUG : BROWSER_OUTPUT: Values: 5045.2 01:13:51 INFO - 2015-11-20 01:13:51,627 DEBUG : BROWSER_OUTPUT: 01:13:51 INFO - 2015-11-20 01:13:51,627 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1058.20 Median:1058.20 stddev:0.00 (0.0%) 01:13:51 INFO - 2015-11-20 01:13:51,627 DEBUG : BROWSER_OUTPUT: Values: 1058.2 01:13:51 INFO - 2015-11-20 01:13:51,627 DEBUG : BROWSER_OUTPUT: 01:13:51 INFO - 2015-11-20 01:13:51,627 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:695.89 Median:695.89 stddev:0.00 (0.0%) 01:13:51 INFO - 2015-11-20 01:13:51,627 DEBUG : BROWSER_OUTPUT: Values: 695.9 01:13:51 INFO - 2015-11-20 01:13:51,628 DEBUG : BROWSER_OUTPUT: 01:13:51 INFO - 2015-11-20 01:13:51,628 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:12011.90 Median:12011.90 stddev:0.00 (0.0%) 01:13:51 INFO - 2015-11-20 01:13:51,628 DEBUG : BROWSER_OUTPUT: Values: 12011.9 01:13:51 INFO - 2015-11-20 01:13:51,628 DEBUG : BROWSER_OUTPUT: 01:13:51 INFO - 2015-11-20 01:13:51,628 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:25575.00 Median:25575.00 stddev:0.00 (0.0%) 01:13:51 INFO - 2015-11-20 01:13:51,628 DEBUG : BROWSER_OUTPUT: Values: 25575.0 01:13:51 INFO - 2015-11-20 01:13:51,628 DEBUG : BROWSER_OUTPUT: 01:13:51 INFO - 2015-11-20 01:13:51,629 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:633.71 Median:633.71 stddev:0.00 (0.0%) 01:13:51 INFO - 2015-11-20 01:13:51,629 DEBUG : BROWSER_OUTPUT: Values: 633.7 01:13:51 INFO - 2015-11-20 01:13:51,629 DEBUG : BROWSER_OUTPUT: 01:13:51 INFO - 2015-11-20 01:13:51,629 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4850.24 Median:4850.24 stddev:0.00 (0.0%) 01:13:51 INFO - 2015-11-20 01:13:51,629 DEBUG : BROWSER_OUTPUT: Values: 4850.2 01:13:51 INFO - 2015-11-20 01:13:51,629 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 01:13:51 INFO - 2015-11-20 01:13:51,629 DEBUG : BROWSER_OUTPUT: 01:13:52 INFO - 2015-11-20 01:13:52,475 INFO : Browser exited with error code: 0 01:13:52 INFO - 2015-11-20 01:13:52,488 INFO : Completed test v8_7 (00:00:39) 01:13:52 INFO - 2015-11-20 01:13:52,611 INFO : Completed test suite (00:20:10) 01:13:52 INFO - 2015-11-20 01:13:52,612 DEBUG : Working with test: dromaeo_css 01:13:52 INFO - 2015-11-20 01:13:52,612 DEBUG : Generating results file: dromaeo_css 01:13:52 INFO - 2015-11-20 01:13:52,613 DEBUG : Working with test: kraken 01:13:52 INFO - 2015-11-20 01:13:52,613 DEBUG : Generating results file: kraken 01:13:52 INFO - 2015-11-20 01:13:52,613 INFO : javascript benchmark 01:13:52 INFO - 2015-11-20 01:13:52,613 DEBUG : Working with test: v8_7 01:13:52 INFO - 2015-11-20 01:13:52,613 DEBUG : Generating results file: v8_7 01:13:52 INFO - 2015-11-20 01:13:52,614 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 01:13:52 INFO - 2015-11-20 01:13:52,664 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,1,43]] 01:13:52 INFO - 2015-11-20 01:13:52,665 DEBUG : process_Request line: dromaeo_css 7200.18 graph.html#tests=[[72,1,43]] 01:13:52 INFO - 2015-11-20 01:13:52,665 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 01:13:52 INFO - 2015-11-20 01:13:52,697 DEBUG : process_Request line: kraken 1519.70 graph.html#tests=[[232,1,43]] 01:13:52 INFO - 2015-11-20 01:13:52,697 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 01:13:52 INFO - 2015-11-20 01:13:52,727 DEBUG : process_Request line: v8_7 21363.71 graph.html#tests=[[230,1,43]] 01:13:52 INFO - 2015-11-20 01:13:52,728 INFO : javascript benchmark 01:13:52 INFO - 2015-11-20 01:13:52,732 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3254.5931758530182, 3334.8832790852325, 3355.5302257683943, 3376.2065914510085, 3381.2223188666608, 5383.16560933056, 5561.47166019228, 5572.164175373696, 5607.439256074391, 5615.887682246353, 5510.9448905510935, 5531.917021244684, 5537.501624853762, 5633.774649014034, 5664.631798933066, 5023.497650234984, 5067.847964561069, 5138.254953031808, 5155.922661160085, 5164.328637277149, 5074.314967479399, 5186.910748742768, 5224.059669259532, 5251.658642188265, 5279.023380674568, 4895.730734809584, 4973.5523802857915, 5018.473060328686, 5089.821856235014, 5110.667806592578, 5119.846404607868, 5122.206058061007, 5142.202958541432, 5142.871428214325, 5150.690958542462, 5093.617978651616, 5122.462141475166, 5132.435432102466, 5133.358330208724, 5163.380394352665, 5195.168772996302, 5224.582033437316, 5308.734563271821, 5312.601554883399, 5315.973420132913, 5866.823995280149, 5876.676782776945, 5877.5591830612875, 5882.058870580687, 5883.499902508292, 5781.4507621775865, 5920.141579470996, 5927.199828023205, 5948.167256584082, 5972.044472884318, 5518.448155184489, 5584.413636568183, 5587.972060139755, 5639.746211420496, 5657.066584013633, 6041.78853740117, 6051.546134039877, 6060.121282414026, 6101.755929762849, 6106.358832322631, 5737.282839645044, 5816.272965879265, 5851.64890106595, 5905.291365036137, 5932.7330270137945, 5932.49573786233, 6003.489703375262, 6016.338202797776, 6017.819465416044, 6021.976264035125, 5926.081457374114, 6021.939780602138, 6064.36324185963, 6065.029595264737, 6068.939310606926, 5782.190493330937, 5910.8817823643285, 5918.644881307049, 5991.700414979234, 6073.787417440457, 4580.541945805393, 4644.16405047088, 4645.117427688729, 4670.953290467051, 4686.39076920005, 4093.099518106012, 4121.381792731055, 4128.0711839836395, 4143.523494798076, 4170.91658166835, 5420.051490989061, 5548.805791797267, 5549.6115271931385, 5654.321481422256, 5698.715064246771, 5882.794102206402, 5892.793752218652, 5896.380880007623, 5898.14476900847, 6059.969700151559, 5558.77764889408, 5565.0817615093865, 5569.944300556943, 5570.41510641385, 5596.468335508121, 5056.317397151411, 5171.81898633546, 5185.351831021122, 5230.424653288135, 5244.134717771525, 6045.1234570987845, 6099.176611157525, 6128.9693551531955, 6133.478654314344, 6142.6314421134875, 5796.681182534832, 5865.501432378295, 5867.6772777497645, 5873.647581145145, 5899.410058994066, 6104.084387341934, 6133.969330153321, 6218.533609979179, 6228.377162283736, 6232.314445411092, 5822.184894114912, 5951.7619295227705, 6014.6391216527145, 6019.307779605401, 6026.849328766641, 5707.229524014205, 5835.79574714883, 6016.338202797776, 6108.236470441195, 6112.358202388685, 5788.62373945709, 5841.269841269841, 5857.150713146655, 5857.58996870232, 5924.377940316204, 5901.468867801918, 5919.822405327847, 5931.288245410406, 5937.435943585352, 5938.495227905676, 5444.646098003617, 5491.203775452617, 5608.298962629671, 5851.327097383855, 5860.062390017577, 5753.05074662676, 5781.624194427349, 5783.219265399285, 5790.768369265183, 5798.072308430631, 5596.832095037155, 5633.746481408264, 5645.943540564542, 5654.208410822406, 5671.291088613923], "unit": "ms", "name": "dojo.html", "value": 5494.1500624139335}, {"lowerIsBetter": false, "replicates": [578.5574035862563, 591.6804925340316, 593.2406519654843, 595.327280173404, 595.4402861310368, 30499.390012199772, 38977.80511097444, 39816.99999999996, 39888.60111398885, 39966.60033399665, 43233.35149972753, 43356.13287734243, 43406.0, 43626.34560481595, 43678.781606092, 8620.74137775866, 8716.694915677952, 8745.868811967794, 8818.911810881906, 8856.8671469928, 8566.31469482443, 8691.782705432382, 8703.782405439882, 8720.912790872073, 8755.912440875574, 8598.957005214996, 8637.136286371344, 8711.651533938635, 8717.95641021794, 8718.520481373522, 8795.912040879606, 8812.206901378842, 8834.072422395653, 8867.778305542413, 8885.378023538355, 8636.784080397978, 8712.825743485158, 8736.43213191147, 8787.824243515093, 8788.956055219684, 39967.60032399668, 40185.39721904174, 40263.7986810067, 40267.0, 40569.0, 3300.405926933151, 3374.5444365010653, 3470.1498132957586, 3567.661072198137, 3650.872219472306, 29554.556681649792, 30278.697213027808, 30340.089797306115, 30351.089467315796, 30603.846980765175, 3889.358255887775, 3916.784576848272, 4042.43405923171, 4050.1494686115952, 4089.325261331877, 269820.0, 269895.0, 270521.0, 270555.0, 271133.999999998, 55309.72345138249, 56620.71689641525, 58244.7087764567, 59329.70335148297, 59375.40624593699, 54723.0, 54732.452675473534, 54821.72589137029, 54874.45125548773, 55018.449815502136, 15683.921580392253, 15838.366465341487, 15882.285297161656, 15913.761293580606, 15940.123293218985, 10379.584816607252, 10391.740206494898, 10521.52653130611, 10521.789564208826, 10529.157667386591, 19108.0, 19425.61148777045, 19487.0, 19634.31279905225, 19722.112504937024, 7584.241575842371, 7671.693132274647, 7687.577183254863, 7764.767056988299, 7792.220777922275, 859.8710193471029, 943.528235882059, 943.9433633981984, 1004.6985904228702, 1147.1109889835445, 27652.446951060865, 28407.431851362857, 28612.0, 28630.427391452053, 28894.988675396682, 981.9361741486781, 990.3117333453181, 1055.678018204455, 1085.3379438542484, 1116.553953552951, 14713.55859324222, 14946.252687365588, 15026.248687565578, 15125.168115753739, 15136.54590362291, 313173.0, 316134.0, 316354.0, 317651.0, 318757.0, 51082.23376649353, 51173.0, 51271.74364128155, 51375.743121284155, 51607.741961289954, 1313.3761463305045, 1331.4607583928525, 1337.8260826092546, 1343.9193648381324, 1347.070521340272, 27064.729352707007, 27369.0, 28088.719112809427, 28518.144455666363, 28886.85556572204, 42749.57250427456, 43021.784891075346, 43277.3508397368, 43298.8866057724, 43345.56654433415, 261712.0, 262825.0, 262939.0, 263229.0, 263317.0, 30550.388992220476, 31421.52867707032, 32024.199395015312, 32188.839055804572, 32264.516032259064, 42567.47670254383, 42628.573714262464, 43914.56085439232, 43915.34126988162, 44462.77768611136, 32984.240873797, 35834.28331433304, 36171.457428139125, 36191.638083618825, 36555.63444365629, 35429.46855797114, 36229.818850905576, 36470.0, 36516.26967460689, 36872.26255474929, 33307.33385332328, 33498.0, 33927.66072339245, 35246.29507409786, 35428.82285588659, 30893.536596950613, 31865.36269274648, 32143.839280803448, 32884.342313154084, 32896.83551582227, 24020.39949001289, 24718.13486527963, 24896.62655060212, 24933.252002439956, 25069.87465062663], "unit": "ms", "name": "ext.html", "value": 18261.81795004182}, {"lowerIsBetter": false, "replicates": [348.1071052749697, 355.0732587945462, 359.20794647801597, 360.9819509024548, 362.7587654209951, 10868.945655271733, 11184.217104802667, 16183.757243641356, 17157.48527544174, 18361.173747181358, 17212.913935430337, 17453.7381939271, 17489.125543722796, 17721.64556708865, 17863.464096077107, 5645.125005624135, 5831.737571809279, 5838.241028666289, 5839.386864379243, 5852.239208902858, 5762.193292938992, 5907.556933230004, 6113.296970848342, 6115.541334399915, 6116.174316467264, 6076.544259180557, 6081.270247570298, 6099.146119543268, 6225.315215326311, 6372.076048972896, 6284.27730810958, 6340.84147896304, 6403.391677790602, 6413.198350206224, 6726.495512836508, 6414.230292364946, 6451.612903225821, 6452.0967064610995, 6463.903041454382, 6473.546851720382, 22121.66817497739, 22513.887430562743, 22884.65673014906, 24022.399440013964, 24177.879110604335, 2183.5196256823474, 2234.6201145805253, 2234.8100411465043, 2484.7887929526014, 2882.1497658190674, 13888.4444622215, 14398.424063037466, 14666.926665366605, 14778.408863645442, 14969.925150374287, 1999.1203870297168, 2011.3563659628924, 2015.9596808063902, 2031.0758604834764, 2057.6399130152313, 55898.0, 56373.43626563723, 56397.71801141009, 63226.59413960168, 71237.64381178113, 15001.32494037771, 15583.610409739847, 15673.0, 15673.68652626941, 15704.528864134094, 24421.14525991582, 24513.0, 24666.260012199662, 24685.87657061703, 24735.505289894103, 8296.377771667148, 8656.913430865736, 8724.738257852274, 8780.868286975701, 8814.338924580683, 7389.0, 7398.519096258834, 7448.590327532038, 7481.663325150382, 7494.5128566643, 7972.644650409445, 8016.519008859487, 8028.959855200686, 8068.9596552016865, 8089.919100809035, 1814.7640806695044, 3088.3051313454293, 3124.173152479425, 3136.9728212275263, 3184.219866132766, 784.9160478928454, 912.9041450647719, 943.3538026451903, 982.2221778580649, 991.4844280973854, 16230.675386492205, 16441.0, 16634.75047874283, 16768.664626707643, 16881.493555193363, 920.7928216151446, 922.9492377919279, 930.3952430919957, 978.0, 1022.0954455306958, 9514.47670378122, 9674.56464459101, 9694.806103877883, 9785.36395134314, 9870.457124858201, 507814.0, 509306.0, 522750.0, 523655.0, 527160.0, 77912.2208777905, 79685.60157199293, 79787.60106199431, 80868.59565702133, 81473.18526814655, 1077.49357801833, 1078.8921107889148, 1081.6971248050559, 1081.7944590527775, 1091.2743025887696, 15131.773023404878, 15139.318730657367, 15172.393104276147, 15246.313915874034, 15392.384304627689, 34580.65419345774, 35172.062248254086, 35208.82395588108, 35907.46138807972, 36231.09422264464, 42918.57081429146, 44179.77910110429, 44537.0, 45084.0, 45188.322175168054, 8873.556322183995, 9380.76548086276, 9825.0, 9867.506624668882, 9924.603015879573, 16532.917335413727, 16570.917145414194, 17134.629229661346, 17468.563285917953, 18042.63914721672, 14092.0, 14440.350184241524, 14450.783238251644, 14547.563573092824, 14767.483138090116, 14187.361568729226, 14378.209198494184, 14520.85479145195, 14718.926405368333, 15084.24578771079, 15178.468753593572, 15249.923750381176, 15426.46007389736, 15588.298526566105, 15731.44939927097, 8107.554084525408, 8640.0, 8832.602532886163, 9033.187013168847, 9052.54737263121, 9319.906800931903, 12460.0, 13169.73660526765, 13266.734665306447, 14000.36998335057], "unit": "ms", "name": "jquery.html", "value": 9757.177965422568}, {"lowerIsBetter": false, "replicates": [1449.0436312034055, 1452.7457694903392, 1542.1980570103547, 1643.1948345310802, 1654.2969238073815, 7579.507332023414, 7790.104138024129, 7816.1402245753, 7831.490953088052, 7965.402594805384, 7927.40544459165, 7967.482113662608, 8028.875957365974, 8042.879356809653, 8051.275385215329, 2213.1147540983616, 2225.7996780289773, 2239.1267405711787, 2242.1479837661745, 2243.3942835434423, 2233.4081468410886, 2244.057495851738, 2294.0, 2297.322289924476, 2299.1033496936125, 1948.4836518322586, 1971.5761111361055, 2218.800307972282, 2263.660450932365, 2267.206477732797, 2198.1317379635034, 2226.699395581592, 2269.341890851651, 2270.557241337948, 2271.068861766684, 2241.170766816272, 2242.4842286274247, 2253.5718213539376, 2261.5929132756096, 2278.851874628144, 7705.460617756759, 7785.766427007199, 7806.687732490694, 7811.687532498693, 7812.453128281023, 4495.14592227479, 4608.769561521944, 4612.515685852971, 4616.261398176276, 4629.930551041737, 2948.9531216418077, 3004.7145521175453, 3068.6931306869355, 3112.439760843047, 3114.6106736657916, 954.5847556312957, 959.3764053365298, 961.8268711631904, 970.4613939263705, 1015.5430056474615, 10556.577736890515, 10570.418626975514, 10571.78856422875, 10600.787984240273, 10604.098651614622, 3997.9000524986527, 4061.89845253871, 4095.85664501747, 4107.0, 4120.896977575585, 8605.65577376898, 8610.13898610134, 8612.09572994839, 8612.311015118776, 8640.524771137647, 4607.6313894889, 4635.6523260755575, 4640.187967105743, 4659.95340046602, 4676.742779147112, 4230.111676547898, 4266.210751011073, 4289.0992891492515, 4299.0, 4311.719738217006, 3416.8120753358307, 3419.093940105874, 3426.9143271418416, 3431.107911942913, 3435.553378060886, 1056.3239526702916, 1059.777446736194, 1066.5307264803462, 1069.5080263078914, 1070.464767616192, 1034.3586976074882, 1055.0188324857802, 1084.8806631270554, 1180.5690922813283, 1287.665207046156, 7191.532550384313, 7220.458465614995, 7232.529885557422, 7238.529495582876, 7266.818329541698, 1112.6342812990767, 1114.4260705736551, 1126.4761885723178, 1131.1629394248362, 1147.9311241325547, 5785.8553536161935, 5794.942050579441, 5826.883462330729, 5838.474537291664, 5841.620294680917, 8844.425112367675, 8883.333749968779, 9101.226395756303, 9207.815843683089, 9279.907200928039, 8991.595378207996, 9052.50211238375, 9092.545372731469, 9171.037041110587, 9182.72451826433, 6780.694868730919, 7011.509194356346, 7087.7164913402885, 7098.893516597255, 7205.531640443354, 7109.60897150641, 7145.285471453021, 7184.712611495691, 7229.530080544748, 7247.420206383371, 7697.230276972258, 7953.960230198812, 8004.279614834692, 8173.959130204311, 8178.100408955129, 8141.8778718320455, 8254.298384637133, 8274.172582741678, 8335.374846886629, 8383.496990180609, 6830.248672646105, 6851.862962740617, 7017.087778588955, 7024.789256322319, 7031.542949708252, 7581.393488521016, 7591.316781489692, 7600.2779735925, 7609.695612175451, 7620.199879012624, 6934.93065069363, 7003.614801185984, 7020.192677841909, 7194.028806111317, 7209.206987231505, 6798.048273241849, 6946.270641582763, 7022.40309573692, 7031.859362812817, 7035.542689725152, 6871.381575658214, 6891.793246202622, 6907.930920690729, 6922.688479018356, 6925.515213935178, 6369.426751592379, 6378.1070650108095, 6386.297507274103, 6400.39196276353, 6414.0, 6628.370304821035, 6631.602103873783, 6650.667466626746, 6656.134702488645, 6688.097106890702], "unit": "ms", "name": "mootools.html", "value": 4419.5569801133}, {"lowerIsBetter": false, "replicates": [311.54203321117956, 317.6014102301611, 322.99192520186995, 323.1307782066243, 324.1976109129904, 6355.459785918197, 6374.808755737336, 6446.935530644698, 6461.483081353498, 6530.085787989685, 6293.811185664426, 6344.555881088326, 6362.30014698384, 6365.395287447696, 6365.458935990447, 4577.748223847687, 4690.413698287714, 4744.383230180072, 4783.641226907978, 4786.042791441708, 4728.101660684459, 4734.739589322586, 4738.857834264978, 4741.834035808747, 4766.809327626891, 4680.5787479126875, 4687.367205427275, 4688.554587314216, 4690.0, 4706.8352607658735, 4691.577758001779, 4702.200625893589, 4703.694259873115, 4712.976435117803, 4713.787879545429, 3930.0174956260935, 3969.384745364473, 3991.4212439196444, 3994.1013272013856, 4057.6550993165615, 5922.31893332268, 5932.228810254639, 5937.376575459558, 5937.940620593825, 5949.405059494059, 5429.891402171974, 5481.671099734029, 5484.2047903053835, 5484.972575137139, 5489.423610520877, 6570.512020993698, 6628.536002479828, 6654.500912431587, 6675.699593518303, 6681.365270299314, 4346.978265108654, 4359.193549193377, 4391.429114215163, 4398.0, 4400.823967041314, 6877.2091209511045, 6911.067005954182, 6913.89629155563, 6924.723011079551, 6942.548734332252, 4441.578050085237, 4466.575675310905, 4470.977645111753, 4471.642268618502, 4472.038511719931, 4454.621357184611, 4521.954780452219, 4525.275955847049, 4538.205813982539, 4541.409616749801, 5456.345238571397, 5461.044317244546, 5463.754131064112, 5464.480874317013, 5471.972640136853, 6703.195616525951, 6710.261871194165, 6719.832004199837, 6722.327767223239, 6761.391474767196, 1626.6421387294777, 1645.489898131583, 1649.2495914358938, 1650.133679818105, 1653.6857996980534, 1061.2412125330425, 1063.1972860490434, 1074.382230217628, 1087.8096333141668, 1092.5192915117323, 6454.935450645434, 6510.153680021567, 6523.478121750249, 6537.071563888664, 6563.606183628997, 6943.132108486439, 6946.0, 6952.374286314155, 6988.825279368057, 6993.2657071006815, 6533.673316334164, 6571.34286571339, 6572.34276572339, 6587.440067594212, 6595.736170553124, 3758.8684396046556, 3797.867074652374, 3815.96968818423, 3823.369144091194, 3826.693864490834, 7298.6715597797165, 7338.22948590401, 7355.485116041826, 7357.0803649543805, 7370.48406611532, 7191.712331506786, 7208.35124838767, 7220.9638951805955, 7242.203357630657, 7267.345938865422, 7155.67799449026, 7302.525335853153, 7336.413086953031, 7349.30181632744, 7350.448716346295, 6967.233604303624, 6976.6860491277, 7025.754098606524, 7035.577865328097, 7050.753223637148, 6969.198542167513, 6974.721011159497, 6974.930250697428, 6975.895361569682, 6985.336393042653, 7189.388901943394, 7325.267473252632, 7362.153352364332, 7370.189279179393, 7375.262473752582, 4665.2302370108555, 4716.622670186445, 4724.220503616864, 4728.361671174485, 4735.100330937111, 6891.965540172267, 6900.482463815133, 6933.7226510939, 6954.443644508528, 6958.930410696031, 6585.209774827052, 6725.562838415487, 6728.428083612947, 6732.899006515004, 6743.662816859235, 6689.09697190873, 6691.799246022627, 6707.429868461236, 6710.798676039727, 6722.983105068362, 6402.6158430494315, 6552.737890484327, 6601.801945941629, 6608.207015158212, 6615.073889655549, 6656.667166641745, 6730.360615741497, 6747.0, 6760.425363844129, 6819.113515242987, 6633.402993730588, 6651.966740166462, 6664.366885145903, 6665.466762658879, 6678.966605166943], "unit": "ms", "name": "prototype.html", "value": 5004.535718010708}, {"lowerIsBetter": false, "replicates": [796.7251298302084, 801.7795106345756, 830.5902734810048, 849.2993280543553, 850.8170743290192, 13616.795748063787, 13753.587392378246, 13758.656033599165, 13867.861321386783, 13875.236861972588, 13038.934805325984, 13223.404946777395, 13252.403641836116, 13263.137896036775, 13286.867131328683, 794.7019867549669, 815.0830315894618, 828.457360428917, 833.1959658929162, 834.5618550261131, 808.3815880851154, 809.720646376999, 813.2802469814197, 816.9223923727266, 820.1183727492939, 860.6686425726109, 864.8400045991511, 868.7306934850217, 869.6695255802786, 871.4901782457271, 853.15111464093, 857.7984173719202, 857.9442336248186, 861.3109512390125, 865.4244927123456, 633.1863555331423, 637.031711798069, 640.3852301790287, 640.7821340744123, 641.2881701311541, 13893.652658683513, 13949.442022319095, 14048.227347495884, 14061.929690351584, 14126.646833829236, 12163.2702037878, 12459.688507787287, 12557.811632825424, 12562.497500100077, 12599.748005039939, 10043.849342259871, 10052.14556762676, 10115.595376184943, 10124.746881327952, 10212.131968782662, 3453.723702103851, 3551.4317709166407, 3578.928421431583, 3639.836207370675, 3673.3020726061964, 49295.0, 50009.74995125038, 50030.499695002945, 50705.746471267405, 50775.746121269156, 9899.802003960025, 10077.949610251902, 10122.342047767019, 10148.340357876714, 10169.440680762482, 17521.0, 17665.558361041076, 17678.204480798395, 17685.469435916944, 17688.29246830138, 7434.442416818761, 7565.962170189224, 7569.583672898044, 7598.0502437195355, 7737.767866964, 4108.4864391951005, 4190.308599081179, 4311.07311927937, 4344.435223420998, 4410.691251612357, 3121.7970831895855, 3128.9361617050313, 3130.201798541357, 3132.3265497918055, 3185.840707964639, 568.6445971267957, 577.3908526504578, 578.9942100578941, 580.756082445374, 584.8187062010705, 633.3729607688448, 671.4997326991422, 727.0366764037672, 732.7948174511146, 742.524784138152, 8460.323174146177, 8592.613332400057, 8791.824163516694, 9065.637374505079, 9262.16640502358, 680.9319068093151, 688.3426327856885, 690.5683947532792, 707.38104158861, 709.3367701199292, 4122.773247471418, 4195.91608167835, 4343.9348409773875, 4378.824847006148, 4557.0, 55417.0, 56144.71927640335, 56642.0, 57154.14268785971, 57577.0, 49813.0, 50669.0, 50984.74507627438, 51512.48487515152, 51738.48261517412, 45662.315065274044, 45757.084858302645, 45981.0, 46332.5366746335, 46400.767996159804, 8685.478871267744, 9037.855755742243, 9077.364584479023, 9106.408083474553, 9133.834661603523, 35019.0, 35248.295034098664, 36173.457398138526, 36281.63718362888, 36321.0, 40699.0, 43274.567254327056, 44861.32708009317, 44884.0, 45335.31997019982, 11236.055643143918, 11372.886271137513, 11411.543538258376, 11645.359505227294, 11761.529538818693, 12147.453364598437, 12335.876641233473, 12451.564195253122, 12658.810117848056, 13267.66830829237, 11307.434628268718, 11771.823422648838, 11800.232984855957, 11966.162368634112, 12182.634520964386, 11383.715407114889, 11952.342621155572, 11994.0, 12240.693982650506, 12330.0, 11354.716132096764, 11372.203945724052, 11479.25384849982, 11510.94244528772, 11779.823302650295, 9906.554205060933, 9946.086261980772, 10035.74910627211, 10183.949080254552, 10225.795484090426, 9217.262618990599, 9369.81260374775, 9774.0, 9996.200303975518, 10049.949750251202], "unit": "ms", "name": "yui.html", "value": 6434.452618783256}], "name": "dromaeo_css", "value": 7200.1820337283}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [111.0, 105.0, 110.0, 112.0, 111.0, 122.0, 110.0, 109.0, 110.0, 110.0], "unit": "ms", "name": "ai-astar", "value": 111.0}, {"lowerIsBetter": true, "replicates": [154.0, 127.0, 158.0, 158.0, 124.0, 152.0, 156.0, 126.0, 165.0, 125.0], "unit": "ms", "name": "audio-beat-detection", "value": 144.5}, {"lowerIsBetter": true, "replicates": [163.0, 163.0, 160.0, 161.0, 162.0, 161.0, 160.0, 163.0, 176.0, 161.0], "unit": "ms", "name": "audio-dft", "value": 163.0}, {"lowerIsBetter": true, "replicates": [73.0, 74.0, 73.0, 72.0, 74.0, 72.0, 73.0, 72.0, 132.0, 74.0], "unit": "ms", "name": "audio-fft", "value": 78.9}, {"lowerIsBetter": true, "replicates": [93.0, 91.0, 130.0, 91.0, 90.0, 91.0, 132.0, 91.0, 90.0, 142.0], "unit": "ms", "name": "audio-oscillator", "value": 104.1}, {"lowerIsBetter": true, "replicates": [110.0, 109.0, 109.0, 110.0, 110.0, 109.0, 109.0, 110.0, 110.0, 110.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 109.6}, {"lowerIsBetter": true, "replicates": [150.0, 146.0, 147.0, 148.0, 147.0, 146.0, 147.0, 146.0, 148.0, 148.0], "unit": "ms", "name": "imaging-darkroom", "value": 147.3}, {"lowerIsBetter": true, "replicates": [97.0, 96.0, 96.0, 96.0, 96.0, 96.0, 97.0, 96.0, 95.0, 96.0], "unit": "ms", "name": "imaging-desaturate", "value": 96.1}, {"lowerIsBetter": true, "replicates": [63.0, 64.0, 63.0, 63.0, 62.0, 63.0, 62.0, 62.0, 60.0, 59.0], "unit": "ms", "name": "json-parse-financial", "value": 62.1}, {"lowerIsBetter": true, "replicates": [70.0, 69.0, 68.0, 70.0, 69.0, 70.0, 69.0, 69.0, 70.0, 69.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 69.3}, {"lowerIsBetter": true, "replicates": [91.0, 92.0, 84.0, 86.0, 93.0, 85.0, 84.0, 86.0, 94.0, 85.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 88.0}, {"lowerIsBetter": true, "replicates": [122.0, 129.0, 121.0, 119.0, 131.0, 135.0, 126.0, 128.0, 120.0, 119.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 125.0}, {"lowerIsBetter": true, "replicates": [148.0, 151.0, 152.0, 167.0, 153.0, 152.0, 151.0, 152.0, 158.0, 141.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 152.5}, {"lowerIsBetter": true, "replicates": [71.0, 67.0, 68.0, 69.0, 69.0, 71.0, 67.0, 66.0, 69.0, 66.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 68.3}], "name": "kraken", "value": 1519.7}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [165.59032952475576], "unit": "score", "name": "Richards", "value": 213.18877800000007}, {"lowerIsBetter": false, "replicates": [192.3816852635629], "unit": "score", "name": "DeltaBlue", "value": 343.681364}, {"lowerIsBetter": false, "replicates": [281.5315315315315], "unit": "score", "name": "Encrypt", "value": 945.4749119999998}, {"lowerIsBetter": false, "replicates": [5045.226130653266], "unit": "score", "name": "Decrypt", "value": 52.75898306772911}, {"lowerIsBetter": false, "replicates": [1058.2010582010582], "unit": "score", "name": "RayTrace", "value": 699.2896049999997}, {"lowerIsBetter": false, "replicates": [695.8942240779402], "unit": "score", "name": "Earley", "value": 957.7073310000004}, {"lowerIsBetter": false, "replicates": [12011.904761904761], "unit": "score", "name": "Boyer", "value": 55.483540138751295}, {"lowerIsBetter": false, "replicates": [25575.0], "unit": "score", "name": "RegExp", "value": 35.620136852394914}, {"lowerIsBetter": false, "replicates": [633.7135614702155], "unit": "score", "name": "Splay", "value": 128.59279799999996}, {"lowerIsBetter": false, "replicates": [4850.241545893719], "unit": "score", "name": "NavierStokes", "value": 305.9641434262948}], "name": "v8_7", "value": 21363.714267304083}]} 01:13:52 INFO - RETURN: dromaeo_css: 7200.18 01:13:52 INFO - RETURN: kraken: 1519.70 01:13:52 INFO - RETURN: v8_7: 21363.71 01:13:52 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,1,43]]", "result": "21363.71"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,1,43]]", "result": "1519.70"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,1,43]]", "result": "7200.18"}}} 01:13:52 INFO - Return code: 0 01:13:52 INFO - # TBPL SUCCESS # 01:13:52 INFO - Running post-action listener: _resource_record_post_action 01:13:52 INFO - Running post-run listener: _resource_record_post_run 01:13:53 INFO - Total resource usage - Wall time: 1225s; CPU: 13.0%; Read bytes: 20480; Write bytes: 515493888; Read time: 28; Write time: 585508 01:13:53 INFO - install - Wall time: 15s; CPU: 15.0%; Read bytes: 0; Write bytes: 228048896; Read time: 0; Write time: 402216 01:13:53 INFO - run-tests - Wall time: 1211s; CPU: 13.0%; Read bytes: 20480; Write bytes: 274866176; Read time: 28; Write time: 178876 01:13:53 INFO - Running post-run listener: _upload_blobber_files 01:13:53 INFO - Blob upload gear active. 01:13:53 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 01:13:53 INFO - Copying logs to upload dir... 01:13:53 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1288.775016 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 28 secs) (at 2015-11-20 01:13:53.867350) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-20 01:13:53.870537) ========= 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=1d09c2d9237d126f9c84bbb400000198-1448008032.272440-202366886 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/oQVOJ2MoQVmXNwVzk_sSEg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.010017 build_url: 'https://queue.taskcluster.net/v1/task/oQVOJ2MoQVmXNwVzk_sSEg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2' ========= master_lag: 0.04 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-20 01:13:53.924825) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-20 01:13:53.925181) ========= 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=1d09c2d9237d126f9c84bbb400000198-1448008032.272440-202366886 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004519 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-20 01:13:53.977106) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-20 01:13:53.977414) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-20 01:13:53.977772) ========= ========= Total master_lag: 0.19 =========