builder: b2g-inbound_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-015 starttime: 1448305284.09 results: success (0) buildid: 20151123083129 builduid: 2cfbfbc8246743b9bd45909bf13d6087 revision: 23b800811e2438e2866889353c4e354da9ce0aa9 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-11-23 11:01:24.093539) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-11-23 11:01:24.093990) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-23 11:01:24.094295) ========= 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=70a720fcaf18edea6683c2dc000001ad-1448302623.128361-1466739435 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006544 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-23 11:01:24.125264) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-23 11:01:24.125809) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-23 11:01:24.166569) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 11:01:24.166861) ========= 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=70a720fcaf18edea6683c2dc000001ad-1448302623.128361-1466739435 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004617 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 11:01:24.218426) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-23 11:01:24.218703) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-23 11:01:24.219045) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 11:01:24.219327) ========= 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=70a720fcaf18edea6683c2dc000001ad-1448302623.128361-1466739435 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-11-23 11:01:24-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 222M=0s 2015-11-23 11:01:24 (222 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.176061 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 11:01:24.414914) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 11:01:24.415237) ========= 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=70a720fcaf18edea6683c2dc000001ad-1448302623.128361-1466739435 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017091 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 11:01:24.465284) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 11:01:24.465728) ========= bash -c 'python archiver_client.py mozharness --repo integration/b2g-inbound --rev 23b800811e2438e2866889353c4e354da9ce0aa9 --destination scripts --debug' in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/b2g-inbound --rev 23b800811e2438e2866889353c4e354da9ce0aa9 --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=70a720fcaf18edea6683c2dc000001ad-1448302623.128361-1466739435 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-11-23 11:01:25,026 truncating revision to first 12 chars 2015-11-23 11:01:25,026 Setting DEBUG logging. 2015-11-23 11:01:25,026 attempt 1/10 2015-11-23 11:01:25,026 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/b2g-inbound/23b800811e24?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-11-23 11:01:25,443 unpacking tar archive at: b2g-inbound-23b800811e24/testing/mozharness/ program finished with exit code 0 elapsedTime=0.689685 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 11:01:25.168476) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-23 11:01:25.168774) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-23 11:01:25.177367) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-23 11:01:25.177671) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-23 11:01:25.178078) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 57 secs) (at 2015-11-23 11:01:25.178377) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name B2G-Inbound --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch B2G-Inbound in dir /builds/slave/test-pgo/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'B2G-Inbound', '--system-bits', '64', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'B2G-Inbound'] 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=70a720fcaf18edea6683c2dc000001ad-1448302623.128361-1466739435 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 11:01:25 INFO - MultiFileLogger online at 20151123 11:01:25 in /builds/slave/test-pgo 11:01:25 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name B2G-Inbound --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch B2G-Inbound 11:01:25 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 11:01:25 INFO - {'append_to_log': False, 11:01:25 INFO - 'base_work_dir': '/builds/slave/test-pgo', 11:01:25 INFO - 'blob_upload_branch': 'B2G-Inbound', 11:01:25 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 11:01:25 INFO - 'branch': 'B2G-Inbound', 11:01:25 INFO - 'buildbot_json_path': 'buildprops.json', 11:01:25 INFO - 'config_files': ('talos/linux_config.py',), 11:01:25 INFO - 'default_actions': ('clobber', 11:01:25 INFO - 'read-buildbot-config', 11:01:25 INFO - 'download-and-extract', 11:01:25 INFO - 'populate-webroot', 11:01:25 INFO - 'create-virtualenv', 11:01:25 INFO - 'install', 11:01:25 INFO - 'run-tests'), 11:01:25 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 11:01:25 INFO - 'download_minidump_stackwalk': True, 11:01:25 INFO - 'download_symbols': 'ondemand', 11:01:25 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 11:01:25 INFO - 'tooltool.py': '/tools/tooltool.py', 11:01:25 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 11:01:25 INFO - '/tools/misc-python/virtualenv.py')}, 11:01:25 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 11:01:25 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 11:01:25 INFO - 'installer_path': 'installer.exe', 11:01:25 INFO - 'log_level': 'info', 11:01:25 INFO - 'log_name': 'talos', 11:01:25 INFO - 'log_to_console': True, 11:01:25 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 11:01:25 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 11:01:25 INFO - 'opt_config_files': (), 11:01:25 INFO - 'pip_index': False, 11:01:25 INFO - 'sps_profile': False, 11:01:25 INFO - 'sps_profile_interval': 0, 11:01:25 INFO - 'suite': 'dromaeojs', 11:01:25 INFO - 'system_bits': '64', 11:01:25 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 11:01:25 INFO - 'title': 'talos-linux64-ix-015', 11:01:25 INFO - 'tooltool_cache': '/builds/tooltool_cache', 11:01:25 INFO - 'use_talos_json': True, 11:01:25 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 11:01:25 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 11:01:25 INFO - 'work_dir': 'build'} 11:01:25 INFO - ##### 11:01:25 INFO - ##### Running clobber step. 11:01:25 INFO - ##### 11:01:25 INFO - Running pre-action listener: _resource_record_pre_action 11:01:25 INFO - Running main action method: clobber 11:01:25 INFO - rmtree: /builds/slave/test-pgo/build 11:01:25 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 11:01:26 INFO - Running post-action listener: _resource_record_post_action 11:01:26 INFO - ##### 11:01:26 INFO - ##### Running read-buildbot-config step. 11:01:26 INFO - ##### 11:01:26 INFO - Running pre-action listener: _resource_record_pre_action 11:01:26 INFO - Running main action method: read_buildbot_config 11:01:26 INFO - Using buildbot properties: 11:01:26 INFO - { 11:01:26 INFO - "properties": { 11:01:26 INFO - "buildnumber": 50, 11:01:26 INFO - "product": "firefox", 11:01:26 INFO - "script_repo_revision": "production", 11:01:26 INFO - "builddir": "b2g-inbound_ubuntu64_hw_test-dromaeojs", 11:01:26 INFO - "repository": "", 11:01:26 INFO - "buildername": "Ubuntu HW 12.04 x64 b2g-inbound pgo talos dromaeojs", 11:01:26 INFO - "buildid": "20151123083129", 11:01:26 INFO - "slavename": "talos-linux64-ix-015", 11:01:26 INFO - "pgo_build": "True", 11:01:26 INFO - "basedir": "/builds/slave/test-pgo", 11:01:26 INFO - "project": "", 11:01:26 INFO - "platform": "ubuntu64_hw", 11:01:26 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 11:01:26 INFO - "slavebuilddir": "test", 11:01:26 INFO - "scheduler": "tests-b2g-inbound-linux64-pgo-talos", 11:01:26 INFO - "branch": "b2g-inbound", 11:01:26 INFO - "repo_path": "integration/b2g-inbound", 11:01:26 INFO - "stage_platform": "linux64-pgo", 11:01:26 INFO - "builduid": "2cfbfbc8246743b9bd45909bf13d6087", 11:01:26 INFO - "revision": "23b800811e2438e2866889353c4e354da9ce0aa9" 11:01:26 INFO - }, 11:01:26 INFO - "sourcestamp": { 11:01:26 INFO - "repository": "", 11:01:26 INFO - "hasPatch": false, 11:01:26 INFO - "project": "", 11:01:26 INFO - "branch": "b2g-inbound-linux64-pgo-talos", 11:01:26 INFO - "changes": [ 11:01:26 INFO - { 11:01:26 INFO - "category": null, 11:01:26 INFO - "files": [ 11:01:26 INFO - { 11:01:26 INFO - "url": null, 11:01:26 INFO - "name": "https://queue.taskcluster.net/v1/task/ympYqEcbRjyjKqcI_KLc1A/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2" 11:01:26 INFO - } 11:01:26 INFO - ], 11:01:26 INFO - "repository": "", 11:01:26 INFO - "rev": "23b800811e2438e2866889353c4e354da9ce0aa9", 11:01:26 INFO - "who": "sendchange", 11:01:26 INFO - "when": 1448305231, 11:01:26 INFO - "number": 6696258, 11:01:26 INFO - "comments": "", 11:01:26 INFO - "project": "", 11:01:26 INFO - "at": "Mon 23 Nov 2015 11:00:31", 11:01:26 INFO - "branch": "b2g-inbound-linux64-pgo-talos", 11:01:26 INFO - "revlink": "", 11:01:26 INFO - "properties": [ 11:01:26 INFO - [ 11:01:26 INFO - "buildid", 11:01:26 INFO - "20151123083129", 11:01:26 INFO - "Change" 11:01:26 INFO - ], 11:01:26 INFO - [ 11:01:26 INFO - "builduid", 11:01:26 INFO - "2cfbfbc8246743b9bd45909bf13d6087", 11:01:26 INFO - "Change" 11:01:26 INFO - ], 11:01:26 INFO - [ 11:01:26 INFO - "pgo_build", 11:01:26 INFO - "True", 11:01:26 INFO - "Change" 11:01:26 INFO - ] 11:01:26 INFO - ], 11:01:26 INFO - "revision": "23b800811e2438e2866889353c4e354da9ce0aa9" 11:01:26 INFO - } 11:01:26 INFO - ], 11:01:26 INFO - "revision": "23b800811e2438e2866889353c4e354da9ce0aa9" 11:01:26 INFO - } 11:01:26 INFO - } 11:01:26 INFO - Found installer url https://queue.taskcluster.net/v1/task/ympYqEcbRjyjKqcI_KLc1A/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2. 11:01:26 INFO - Running post-action listener: _resource_record_post_action 11:01:26 INFO - ##### 11:01:26 INFO - ##### Running download-and-extract step. 11:01:26 INFO - ##### 11:01:26 INFO - Running pre-action listener: _resource_record_pre_action 11:01:26 INFO - Running main action method: download_and_extract 11:01:26 INFO - mkdir: /builds/slave/test-pgo/build/tests 11:01: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')]} 11:01:26 INFO - https://queue.taskcluster.net/v1/task/ympYqEcbRjyjKqcI_KLc1A/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 11:01:26 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ympYqEcbRjyjKqcI_KLc1A/artifacts/public/build/test_packages.json 11:01:26 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ympYqEcbRjyjKqcI_KLc1A/artifacts/public/build/test_packages.json 11:01:26 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ympYqEcbRjyjKqcI_KLc1A/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 11:01:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ympYqEcbRjyjKqcI_KLc1A/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 11:01:26 INFO - Downloaded 1302 bytes. 11:01:26 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 11:01:26 INFO - Using the following test package requirements: 11:01:26 INFO - {u'common': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 11:01:26 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 11:01:26 INFO - u'firefox-45.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 11:01:26 INFO - u'jittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 11:01:26 INFO - u'jsshell-linux-x86_64.zip'], 11:01:26 INFO - u'mochitest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 11:01:26 INFO - u'firefox-45.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 11:01:26 INFO - u'mozbase': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 11:01:26 INFO - u'reftest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 11:01:26 INFO - u'firefox-45.0a1.en-US.linux-x86_64.reftest.tests.zip'], 11:01:26 INFO - u'talos': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 11:01:26 INFO - u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'], 11:01:26 INFO - u'web-platform': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 11:01:26 INFO - u'firefox-45.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 11:01:26 INFO - u'webapprt': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 11:01:26 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 11:01:26 INFO - u'firefox-45.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 11:01:26 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 11:01: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')]} 11:01:26 INFO - https://queue.taskcluster.net/v1/task/ympYqEcbRjyjKqcI_KLc1A/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 11:01:26 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ympYqEcbRjyjKqcI_KLc1A/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 11:01:26 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ympYqEcbRjyjKqcI_KLc1A/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 11:01:26 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ympYqEcbRjyjKqcI_KLc1A/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 11:01:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ympYqEcbRjyjKqcI_KLc1A/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 11:01:27 INFO - Downloaded 22525958 bytes. 11:01:27 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 11:01:27 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 11:01:27 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 11:01:29 INFO - Return code: 0 11:01:29 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 11:01:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:01:29 INFO - https://queue.taskcluster.net/v1/task/ympYqEcbRjyjKqcI_KLc1A/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 11:01:29 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ympYqEcbRjyjKqcI_KLc1A/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 11:01:29 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ympYqEcbRjyjKqcI_KLc1A/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 11:01:29 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ympYqEcbRjyjKqcI_KLc1A/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 11:01:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ympYqEcbRjyjKqcI_KLc1A/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 11:01:31 INFO - Downloaded 22525958 bytes. 11:01:31 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 11:01:31 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 11:01:31 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 11:01:32 INFO - Return code: 0 11:01:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:01:32 INFO - https://queue.taskcluster.net/v1/task/ympYqEcbRjyjKqcI_KLc1A/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 11:01:32 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ympYqEcbRjyjKqcI_KLc1A/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 11:01:32 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ympYqEcbRjyjKqcI_KLc1A/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 11:01:32 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ympYqEcbRjyjKqcI_KLc1A/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 11:01:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ympYqEcbRjyjKqcI_KLc1A/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 11:01:33 INFO - Downloaded 11130997 bytes. 11:01:33 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'] in /builds/slave/test-pgo/build/tests 11:01:33 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 11:01:33 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'] with output_timeout 1760 11:01:33 INFO - Return code: 0 11:01:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:01:33 INFO - https://queue.taskcluster.net/v1/task/ympYqEcbRjyjKqcI_KLc1A/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 11:01:33 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ympYqEcbRjyjKqcI_KLc1A/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 11:01:33 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ympYqEcbRjyjKqcI_KLc1A/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 11:01:33 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ympYqEcbRjyjKqcI_KLc1A/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 11:01:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ympYqEcbRjyjKqcI_KLc1A/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 11:01:36 INFO - Downloaded 57551457 bytes. 11:01:36 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/ympYqEcbRjyjKqcI_KLc1A/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 11:01:36 INFO - mkdir: /builds/slave/test-pgo/properties 11:01:36 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 11:01:36 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 11:01:36 INFO - Contents: 11:01:36 INFO - build_url:https://queue.taskcluster.net/v1/task/ympYqEcbRjyjKqcI_KLc1A/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 11:01:36 INFO - Running post-action listener: _resource_record_post_action 11:01:36 INFO - Running post-action listener: set_extra_try_arguments 11:01:36 INFO - ##### 11:01:36 INFO - ##### Running populate-webroot step. 11:01:36 INFO - ##### 11:01:36 INFO - Running pre-action listener: _resource_record_pre_action 11:01:36 INFO - Running main action method: populate_webroot 11:01:36 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 11:01:36 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 11:01:36 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 11:01:36 INFO - '../fennec_ids.txt'], 11:01:36 INFO - 'tests': ['tcheck2']}, 11:01:36 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 11:01:36 INFO - '--tppagecycles', 11:01:36 INFO - '7'], 11:01:36 INFO - 'tests': ['tsvgm']}}, 11:01:36 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 11:01:36 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 11:01:36 INFO - 'tests': ['tresize', 'tcanvasmark']}, 11:01:36 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 11:01:36 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 11:01:36 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 11:01:36 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:01:36 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:01:36 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:01:36 INFO - 'talos_options': ['--e10s'], 11:01:36 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:01:36 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:01:36 INFO - 'tests': ['damp', 'tps']}, 11:01:36 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:01:36 INFO - 'talos_options': ['--e10s'], 11:01:36 INFO - 'tests': ['damp', 'tps']}, 11:01:36 INFO - 'g3': {'tests': ['dromaeo_dom']}, 11:01:36 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 11:01:36 INFO - 'other': {'tests': ['a11yr', 11:01:36 INFO - 'ts_paint', 11:01:36 INFO - 'tpaint', 11:01:36 INFO - 'sessionrestore', 11:01:36 INFO - 'sessionrestore_no_auto_restore']}, 11:01:36 INFO - 'other-e10s': {'talos_options': ['--e10s'], 11:01:36 INFO - 'tests': ['a11yr', 11:01:36 INFO - 'ts_paint', 11:01:36 INFO - 'tpaint', 11:01:36 INFO - 'sessionrestore', 11:01:36 INFO - 'sessionrestore_no_auto_restore']}, 11:01:36 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 11:01:36 INFO - 'tests': ['a11yr', 11:01:36 INFO - 'ts_paint', 11:01:36 INFO - 'tpaint', 11:01:36 INFO - 'sessionrestore', 11:01:36 INFO - 'sessionrestore_no_auto_restore']}, 11:01:36 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 11:01:36 INFO - 'tests': ['a11yr', 11:01:36 INFO - 'ts_paint', 11:01:36 INFO - 'tpaint', 11:01:36 INFO - 'sessionrestore', 11:01:36 INFO - 'sessionrestore_no_auto_restore']}, 11:01:36 INFO - 'other_l64': {'tests': ['a11yr', 11:01:36 INFO - 'ts_paint', 11:01:36 INFO - 'tpaint', 11:01:36 INFO - 'sessionrestore', 11:01:36 INFO - 'sessionrestore_no_auto_restore']}, 11:01:36 INFO - 'other_nol64': {'tests': ['a11yr', 11:01:36 INFO - 'ts_paint', 11:01:36 INFO - 'tpaint', 11:01:36 INFO - 'sessionrestore', 11:01:36 INFO - 'sessionrestore_no_auto_restore']}, 11:01:36 INFO - 'svgr': {'tests': ['tsvgx', 11:01:36 INFO - 'tsvgr_opacity', 11:01:36 INFO - 'tart', 11:01:36 INFO - 'tscrollx', 11:01:36 INFO - 'cart']}, 11:01:36 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 11:01:36 INFO - 'tests': ['tsvgx', 11:01:36 INFO - 'tsvgr_opacity', 11:01:36 INFO - 'tart', 11:01:36 INFO - 'tscrollx', 11:01:36 INFO - 'cart']}, 11:01:36 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:01:36 INFO - 'tests': ['tp5o']}, 11:01:36 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:01:36 INFO - 'talos_options': ['--e10s'], 11:01:36 INFO - 'tests': ['tp5o']}, 11:01:36 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:01:36 INFO - 'talos_options': ['--xperf_path', 11:01:36 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:01:36 INFO - 'tests': ['tp5n']}, 11:01:36 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:01:36 INFO - 'talos_options': ['--e10s', 11:01:36 INFO - '--xperf_path', 11:01:36 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:01:36 INFO - 'tests': ['tp5n']}}, 11:01:36 INFO - 'talos.zip': {'path': '', 11:01:36 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 11:01:36 INFO - Running post-action listener: _resource_record_post_action 11:01:36 INFO - ##### 11:01:36 INFO - ##### Running create-virtualenv step. 11:01:36 INFO - ##### 11:01:36 INFO - Running pre-action listener: _resource_record_pre_action 11:01:36 INFO - Running main action method: create_virtualenv 11:01:36 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 11:01:36 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 11:01:36 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 11:01:36 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 11:01:36 INFO - Using real prefix '/usr' 11:01:36 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 11:01:36 INFO - Installing distribute.............................................................................................................................................................................................done. 11:01:38 INFO - Installing pip.................done. 11:01:38 INFO - Return code: 0 11:01:38 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 11:01:38 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')]} 11:01:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:01:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:01:38 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')]} 11:01:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:01:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:01:38 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 0x7f56774d1c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26c86c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27896e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27bfa90>, '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 0x2811f70>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28122e0>, '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': '70a720fcaf18edea6683c2dc000001ad-1448302623.128361-1466739435', '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 11:01:38 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 11:01:38 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 11:01:38 INFO - Using env: {'DISPLAY': ':0', 11:01:38 INFO - 'HOME': '/home/cltbld', 11:01:38 INFO - 'LANG': 'en_US.UTF-8', 11:01:38 INFO - 'LANGUAGE': 'en_US:en', 11:01:38 INFO - 'LOGNAME': 'cltbld', 11:01:38 INFO - 'MAIL': '/var/mail/cltbld', 11:01:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:01:38 INFO - 'MOZ_NO_REMOTE': '1', 11:01:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:01:38 INFO - 'NO_EM_RESTART': '1', 11:01:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:01:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 11:01:38 INFO - 'PWD': '/builds/slave/test-pgo', 11:01:38 INFO - 'SHELL': '/bin/bash', 11:01:38 INFO - 'SHLVL': '1', 11:01:38 INFO - 'TERM': 'linux', 11:01:38 INFO - 'TMOUT': '86400', 11:01:38 INFO - 'USER': 'cltbld', 11:01:38 INFO - 'XDG_SESSION_COOKIE': '70a720fcaf18edea6683c2dc000001ad-1448302623.128361-1466739435', 11:01:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:01:38 INFO - '_': '/tools/buildbot/bin/python'} 11:01:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:01:39 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 11:01:39 INFO - Cleaning up... 11:01:39 INFO - Return code: 0 11:01:39 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 11:01:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:01:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:01:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:01:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:01:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:01:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:01:39 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 0x7f56774d1c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26c86c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27896e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27bfa90>, '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 0x2811f70>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28122e0>, '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': '70a720fcaf18edea6683c2dc000001ad-1448302623.128361-1466739435', '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 11:01:39 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 11:01:39 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 11:01:39 INFO - Using env: {'DISPLAY': ':0', 11:01:39 INFO - 'HOME': '/home/cltbld', 11:01:39 INFO - 'LANG': 'en_US.UTF-8', 11:01:39 INFO - 'LANGUAGE': 'en_US:en', 11:01:39 INFO - 'LOGNAME': 'cltbld', 11:01:39 INFO - 'MAIL': '/var/mail/cltbld', 11:01:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:01:39 INFO - 'MOZ_NO_REMOTE': '1', 11:01:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:01:39 INFO - 'NO_EM_RESTART': '1', 11:01:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:01:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 11:01:39 INFO - 'PWD': '/builds/slave/test-pgo', 11:01:39 INFO - 'SHELL': '/bin/bash', 11:01:39 INFO - 'SHLVL': '1', 11:01:39 INFO - 'TERM': 'linux', 11:01:39 INFO - 'TMOUT': '86400', 11:01:39 INFO - 'USER': 'cltbld', 11:01:39 INFO - 'XDG_SESSION_COOKIE': '70a720fcaf18edea6683c2dc000001ad-1448302623.128361-1466739435', 11:01:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:01:39 INFO - '_': '/tools/buildbot/bin/python'} 11:01:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:01:39 INFO - Downloading/unpacking psutil>=0.7.1 11:01:39 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 11:01:39 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 11:01:39 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 11:01:39 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 11:01:39 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 11:01:39 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 11:01:40 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 11:01:40 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 11:01:40 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 11:01:41 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:01:41 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:01:41 INFO - Installing collected packages: psutil 11:01:41 INFO - Running setup.py install for psutil 11:01:41 INFO - building 'psutil._psutil_linux' extension 11:01:41 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 11:01:41 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 11:01:41 INFO - building 'psutil._psutil_posix' extension 11:01:41 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 11:01:41 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 11:01:41 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:01:41 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:01:41 INFO - Successfully installed psutil 11:01:41 INFO - Cleaning up... 11:01:41 INFO - Return code: 0 11:01:41 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 11:01: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')]} 11:01:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:01:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:01: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')]} 11:01:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:01:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:01:41 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 0x7f56774d1c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26c86c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27896e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27bfa90>, '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 0x2811f70>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28122e0>, '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': '70a720fcaf18edea6683c2dc000001ad-1448302623.128361-1466739435', '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 11:01:41 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 11:01:41 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 11:01:41 INFO - Using env: {'DISPLAY': ':0', 11:01:41 INFO - 'HOME': '/home/cltbld', 11:01:41 INFO - 'LANG': 'en_US.UTF-8', 11:01:41 INFO - 'LANGUAGE': 'en_US:en', 11:01:41 INFO - 'LOGNAME': 'cltbld', 11:01:41 INFO - 'MAIL': '/var/mail/cltbld', 11:01:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:01:41 INFO - 'MOZ_NO_REMOTE': '1', 11:01:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:01:41 INFO - 'NO_EM_RESTART': '1', 11:01:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:01:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 11:01:41 INFO - 'PWD': '/builds/slave/test-pgo', 11:01:41 INFO - 'SHELL': '/bin/bash', 11:01:41 INFO - 'SHLVL': '1', 11:01:41 INFO - 'TERM': 'linux', 11:01:41 INFO - 'TMOUT': '86400', 11:01:41 INFO - 'USER': 'cltbld', 11:01:41 INFO - 'XDG_SESSION_COOKIE': '70a720fcaf18edea6683c2dc000001ad-1448302623.128361-1466739435', 11:01:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:01:41 INFO - '_': '/tools/buildbot/bin/python'} 11:01:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:01:41 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 11:01:41 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 11:01:41 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 11:01:41 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 11:01:41 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 11:01:41 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 11:01:41 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 11:01:43 INFO - Downloading mozsystemmonitor-0.0.tar.gz 11:01:43 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 11:01:43 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 11:01:43 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 11:01:43 INFO - Installing collected packages: mozsystemmonitor 11:01:43 INFO - Running setup.py install for mozsystemmonitor 11:01:43 INFO - Successfully installed mozsystemmonitor 11:01:43 INFO - Cleaning up... 11:01:43 INFO - Return code: 0 11:01:43 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 11:01:43 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')]} 11:01:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:01:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:01:43 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')]} 11:01:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:01:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:01:43 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 0x7f56774d1c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26c86c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27896e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27bfa90>, '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 0x2811f70>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28122e0>, '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': '70a720fcaf18edea6683c2dc000001ad-1448302623.128361-1466739435', '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 11:01:43 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 11:01:43 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 11:01:43 INFO - Using env: {'DISPLAY': ':0', 11:01:43 INFO - 'HOME': '/home/cltbld', 11:01:43 INFO - 'LANG': 'en_US.UTF-8', 11:01:43 INFO - 'LANGUAGE': 'en_US:en', 11:01:43 INFO - 'LOGNAME': 'cltbld', 11:01:43 INFO - 'MAIL': '/var/mail/cltbld', 11:01:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:01:43 INFO - 'MOZ_NO_REMOTE': '1', 11:01:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:01:43 INFO - 'NO_EM_RESTART': '1', 11:01:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:01:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 11:01:43 INFO - 'PWD': '/builds/slave/test-pgo', 11:01:43 INFO - 'SHELL': '/bin/bash', 11:01:43 INFO - 'SHLVL': '1', 11:01:43 INFO - 'TERM': 'linux', 11:01:43 INFO - 'TMOUT': '86400', 11:01:43 INFO - 'USER': 'cltbld', 11:01:43 INFO - 'XDG_SESSION_COOKIE': '70a720fcaf18edea6683c2dc000001ad-1448302623.128361-1466739435', 11:01:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:01:43 INFO - '_': '/tools/buildbot/bin/python'} 11:01:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:01:43 INFO - Downloading/unpacking blobuploader==1.2.4 11:01:43 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 11:01:43 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 11:01:43 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 11:01:43 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 11:01:43 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 11:01:43 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 11:01:45 INFO - Downloading blobuploader-1.2.4.tar.gz 11:01:45 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 11:01:45 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 11:01:45 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 11:01:45 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 11:01:45 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 11:01:45 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 11:01:45 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 11:01:45 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 11:01:45 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 11:01:45 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 11:01:45 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 11:01:46 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 11:01:46 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 11:01:46 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 11:01:46 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 11:01:46 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 11:01:46 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 11:01:46 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 11:01:46 INFO - Downloading docopt-0.6.1.tar.gz 11:01:46 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 11:01:46 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 11:01:46 INFO - Installing collected packages: blobuploader, requests, docopt 11:01:46 INFO - Running setup.py install for blobuploader 11:01:46 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 11:01:46 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 11:01:46 INFO - Running setup.py install for requests 11:01:46 INFO - Running setup.py install for docopt 11:01:46 INFO - Successfully installed blobuploader requests docopt 11:01:46 INFO - Cleaning up... 11:01:46 INFO - Return code: 0 11:01:46 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 11:01:46 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')]} 11:01:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:01:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:01:46 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')]} 11:01:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:01:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:01:46 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 0x7f56774d1c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26c86c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27896e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27bfa90>, '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 0x2811f70>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28122e0>, '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': '70a720fcaf18edea6683c2dc000001ad-1448302623.128361-1466739435', '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 11:01:46 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 11:01:46 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 11:01:46 INFO - Using env: {'DISPLAY': ':0', 11:01:46 INFO - 'HOME': '/home/cltbld', 11:01:46 INFO - 'LANG': 'en_US.UTF-8', 11:01:46 INFO - 'LANGUAGE': 'en_US:en', 11:01:46 INFO - 'LOGNAME': 'cltbld', 11:01:46 INFO - 'MAIL': '/var/mail/cltbld', 11:01:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:01:46 INFO - 'MOZ_NO_REMOTE': '1', 11:01:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:01:46 INFO - 'NO_EM_RESTART': '1', 11:01:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:01:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 11:01:46 INFO - 'PWD': '/builds/slave/test-pgo', 11:01:46 INFO - 'SHELL': '/bin/bash', 11:01:46 INFO - 'SHLVL': '1', 11:01:46 INFO - 'TERM': 'linux', 11:01:46 INFO - 'TMOUT': '86400', 11:01:46 INFO - 'USER': 'cltbld', 11:01:46 INFO - 'XDG_SESSION_COOKIE': '70a720fcaf18edea6683c2dc000001ad-1448302623.128361-1466739435', 11:01:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:01:46 INFO - '_': '/tools/buildbot/bin/python'} 11:01:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:01:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 11:01:47 INFO - Running setup.py (path:/tmp/pip-jUSPRT-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 11:01:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 11:01:47 INFO - Running setup.py (path:/tmp/pip-37xPP3-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 11:01:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 11:01:47 INFO - Running setup.py (path:/tmp/pip-2jET8n-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 11:01:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 11:01:47 INFO - Running setup.py (path:/tmp/pip-ldOx81-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 11:01:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 11:01:47 INFO - Running setup.py (path:/tmp/pip-5BTnOw-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 11:01:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 11:01:47 INFO - Running setup.py (path:/tmp/pip-96jPP0-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 11:01:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 11:01:47 INFO - Running setup.py (path:/tmp/pip-EY1mSS-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 11:01:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 11:01:47 INFO - Running setup.py (path:/tmp/pip-h_GrmZ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 11:01:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 11:01:47 INFO - Running setup.py (path:/tmp/pip-okuPmj-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 11:01:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 11:01:47 INFO - Running setup.py (path:/tmp/pip-rImSCW-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 11:01:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 11:01:47 INFO - Running setup.py (path:/tmp/pip-gc_qj0-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 11:01:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 11:01:47 INFO - Running setup.py (path:/tmp/pip-JjLSwO-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 11:01:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 11:01:48 INFO - Running setup.py (path:/tmp/pip-vZ1z2u-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 11:01:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 11:01:48 INFO - Running setup.py (path:/tmp/pip-HiilLP-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 11:01:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 11:01:48 INFO - Running setup.py (path:/tmp/pip-K4lmc0-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 11:01:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 11:01:48 INFO - Running setup.py (path:/tmp/pip-bqx6Qy-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 11:01:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 11:01:48 INFO - Running setup.py (path:/tmp/pip-vtCZUd-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 11:01:48 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 11:01:48 INFO - Running setup.py install for manifestparser 11:01:48 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 11:01:48 INFO - Running setup.py install for mozcrash 11:01:48 INFO - Running setup.py install for mozdebug 11:01:48 INFO - Running setup.py install for mozdevice 11:01:48 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 11:01:48 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 11:01:48 INFO - Running setup.py install for mozfile 11:01:48 INFO - Running setup.py install for mozhttpd 11:01:49 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 11:01:49 INFO - Running setup.py install for mozinfo 11:01:49 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 11:01:49 INFO - Running setup.py install for mozInstall 11:01:49 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 11:01:49 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 11:01:49 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 11:01:49 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 11:01:49 INFO - Running setup.py install for mozleak 11:01:49 INFO - Running setup.py install for mozlog 11:01:49 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 11:01:49 INFO - Running setup.py install for moznetwork 11:01:49 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 11:01:49 INFO - Running setup.py install for mozprocess 11:01:49 INFO - Running setup.py install for mozprofile 11:01:49 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 11:01:49 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 11:01:49 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 11:01:49 INFO - Running setup.py install for mozrunner 11:01:49 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 11:01:49 INFO - Running setup.py install for mozscreenshot 11:01:49 INFO - Running setup.py install for moztest 11:01:50 INFO - Running setup.py install for mozversion 11:01:50 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 11:01:50 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 11:01:50 INFO - Cleaning up... 11:01:50 INFO - Return code: 0 11:01:50 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 11:01:50 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')]} 11:01:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:01:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:01:50 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')]} 11:01:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:01:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:01:50 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 0x7f56774d1c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26c86c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27896e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27bfa90>, '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 0x2811f70>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28122e0>, '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': '70a720fcaf18edea6683c2dc000001ad-1448302623.128361-1466739435', '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 11:01:50 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 11:01:50 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 11:01:50 INFO - Using env: {'DISPLAY': ':0', 11:01:50 INFO - 'HOME': '/home/cltbld', 11:01:50 INFO - 'LANG': 'en_US.UTF-8', 11:01:50 INFO - 'LANGUAGE': 'en_US:en', 11:01:50 INFO - 'LOGNAME': 'cltbld', 11:01:50 INFO - 'MAIL': '/var/mail/cltbld', 11:01:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:01:50 INFO - 'MOZ_NO_REMOTE': '1', 11:01:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:01:50 INFO - 'NO_EM_RESTART': '1', 11:01:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:01:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 11:01:50 INFO - 'PWD': '/builds/slave/test-pgo', 11:01:50 INFO - 'SHELL': '/bin/bash', 11:01:50 INFO - 'SHLVL': '1', 11:01:50 INFO - 'TERM': 'linux', 11:01:50 INFO - 'TMOUT': '86400', 11:01:50 INFO - 'USER': 'cltbld', 11:01:50 INFO - 'XDG_SESSION_COOKIE': '70a720fcaf18edea6683c2dc000001ad-1448302623.128361-1466739435', 11:01:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:01:50 INFO - '_': '/tools/buildbot/bin/python'} 11:01:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:01:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 11:01:50 INFO - Running setup.py (path:/tmp/pip-PpsbJK-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 11:01:50 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)) 11:01:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 11:01:50 INFO - Running setup.py (path:/tmp/pip-XXYCwg-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 11:01:50 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)) 11:01:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 11:01:50 INFO - Running setup.py (path:/tmp/pip-pm59b6-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 11:01:50 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)) 11:01:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 11:01:50 INFO - Running setup.py (path:/tmp/pip-IClEzg-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 11:01:50 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)) 11:01:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 11:01:50 INFO - Running setup.py (path:/tmp/pip-BuHWaM-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 11:01:50 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)) 11:01:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 11:01:50 INFO - Running setup.py (path:/tmp/pip-w1JF9a-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 11:01:50 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)) 11:01:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 11:01:50 INFO - Running setup.py (path:/tmp/pip-jY9m8a-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 11:01:50 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)) 11:01:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 11:01:50 INFO - Running setup.py (path:/tmp/pip-4ZveqO-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 11:01:51 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)) 11:01:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 11:01:51 INFO - Running setup.py (path:/tmp/pip-KJRnRB-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 11:01:51 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)) 11:01:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 11:01:51 INFO - Running setup.py (path:/tmp/pip-rPd_Zk-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 11:01:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 11:01:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 11:01:51 INFO - Running setup.py (path:/tmp/pip-999hEv-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 11:01:51 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)) 11:01:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 11:01:51 INFO - Running setup.py (path:/tmp/pip-K5nW0V-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 11:01:51 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)) 11:01:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 11:01:51 INFO - Running setup.py (path:/tmp/pip-GSXHx9-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 11:01:51 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)) 11:01:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 11:01:51 INFO - Running setup.py (path:/tmp/pip-lZVsbm-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 11:01:51 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)) 11:01:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 11:01:51 INFO - Running setup.py (path:/tmp/pip-9v28P3-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 11:01:51 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)) 11:01:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 11:01:51 INFO - Running setup.py (path:/tmp/pip-3YOJ77-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 11:01:51 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)) 11:01:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 11:01:51 INFO - Running setup.py (path:/tmp/pip-ALr1D_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 11:01:51 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)) 11:01:51 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)) 11:01:51 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)) 11:01:51 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)) 11:01:51 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)) 11:01:51 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)) 11:01:51 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 11:01:51 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 11:01:51 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 11:01:51 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 11:01:51 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 11:01:51 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 11:01:51 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 11:01:53 INFO - Downloading blessings-1.5.1.tar.gz 11:01:53 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 11:01:53 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 11:01:53 INFO - Installing collected packages: blessings 11:01:53 INFO - Running setup.py install for blessings 11:01:53 INFO - Successfully installed blessings 11:01:53 INFO - Cleaning up... 11:01:53 INFO - Return code: 0 11:01:53 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 11:01:53 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 11:01:53 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 11:01:53 INFO - Reading from file tmpfile_stdout 11:01:53 INFO - Current package versions: 11:01:53 INFO - argparse == 1.2.1 11:01:53 INFO - blessings == 1.5.1 11:01:53 INFO - blobuploader == 1.2.4 11:01:53 INFO - docopt == 0.6.1 11:01:53 INFO - manifestparser == 1.1 11:01:53 INFO - mozInstall == 1.12 11:01:53 INFO - mozcrash == 0.16 11:01:53 INFO - mozdebug == 0.1 11:01:53 INFO - mozdevice == 0.47 11:01:53 INFO - mozfile == 1.2 11:01:53 INFO - mozhttpd == 0.7 11:01:53 INFO - mozinfo == 0.9 11:01:53 INFO - mozleak == 0.1 11:01:53 INFO - mozlog == 3.1 11:01:53 INFO - moznetwork == 0.27 11:01:53 INFO - mozprocess == 0.22 11:01:53 INFO - mozprofile == 0.27 11:01:53 INFO - mozrunner == 6.11 11:01:53 INFO - mozscreenshot == 0.1 11:01:53 INFO - mozsystemmonitor == 0.0 11:01:53 INFO - moztest == 0.7 11:01:53 INFO - mozversion == 1.4 11:01:53 INFO - psutil == 3.1.1 11:01:53 INFO - requests == 1.2.3 11:01:53 INFO - wsgiref == 0.1.2 11:01:53 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 11:01:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:01:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:01:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:01:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:01:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:01:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:01:53 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 0x7f56774d1c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26c86c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27896e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27bfa90>, '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 0x2811f70>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28122e0>, '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': '70a720fcaf18edea6683c2dc000001ad-1448302623.128361-1466739435', '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 11:01:53 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 11:01:53 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 11:01:53 INFO - Using env: {'DISPLAY': ':0', 11:01:53 INFO - 'HOME': '/home/cltbld', 11:01:53 INFO - 'LANG': 'en_US.UTF-8', 11:01:53 INFO - 'LANGUAGE': 'en_US:en', 11:01:53 INFO - 'LOGNAME': 'cltbld', 11:01:53 INFO - 'MAIL': '/var/mail/cltbld', 11:01:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:01:53 INFO - 'MOZ_NO_REMOTE': '1', 11:01:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:01:53 INFO - 'NO_EM_RESTART': '1', 11:01:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:01:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 11:01:53 INFO - 'PWD': '/builds/slave/test-pgo', 11:01:53 INFO - 'SHELL': '/bin/bash', 11:01:53 INFO - 'SHLVL': '1', 11:01:53 INFO - 'TERM': 'linux', 11:01:53 INFO - 'TMOUT': '86400', 11:01:53 INFO - 'USER': 'cltbld', 11:01:53 INFO - 'XDG_SESSION_COOKIE': '70a720fcaf18edea6683c2dc000001ad-1448302623.128361-1466739435', 11:01:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:01:53 INFO - '_': '/tools/buildbot/bin/python'} 11:01:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:01:53 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)) 11:01:53 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)) 11:01:53 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)) 11:01:53 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)) 11:01:53 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)) 11:01:53 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)) 11:01:54 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)) 11:01:54 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)) 11:01:54 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)) 11:01:54 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)) 11:01:54 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)) 11:01:54 INFO - Cleaning up... 11:01:54 INFO - Return code: 0 11:01:54 INFO - Running post-action listener: _resource_record_post_action 11:01:54 INFO - Running post-action listener: _start_resource_monitoring 11:01:54 INFO - Starting resource monitoring. 11:01:54 INFO - ##### 11:01:54 INFO - ##### Running install step. 11:01:54 INFO - ##### 11:01:54 INFO - Running pre-action listener: _resource_record_pre_action 11:01:54 INFO - Running main action method: install 11:01:54 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 11:01:54 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 11:01:54 INFO - Reading from file tmpfile_stdout 11:01:54 INFO - Detecting whether we're running mozinstall >=1.0... 11:01:54 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 11:01:54 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 11:01:54 INFO - Reading from file tmpfile_stdout 11:01:54 INFO - Output received: 11:01:54 INFO - Usage: mozinstall [options] installer 11:01:54 INFO - Options: 11:01:54 INFO - -h, --help show this help message and exit 11:01:54 INFO - -d DEST, --destination=DEST 11:01:54 INFO - Directory to install application into. [default: 11:01:54 INFO - "/builds/slave/test-pgo"] 11:01:54 INFO - --app=APP Application being installed. [default: firefox] 11:01:54 INFO - mkdir: /builds/slave/test-pgo/build/application 11:01:54 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'] 11:01:54 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 11:02:08 INFO - Reading from file tmpfile_stdout 11:02:08 INFO - Output received: 11:02:08 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 11:02:08 INFO - Running post-action listener: _resource_record_post_action 11:02:08 INFO - ##### 11:02:08 INFO - ##### Running run-tests step. 11:02:08 INFO - ##### 11:02:08 INFO - Running pre-action listener: _resource_record_pre_action 11:02:08 INFO - Running main action method: run_tests 11:02:08 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 11:02:08 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 11:02:08 INFO - Python 2.7.3 11:02:08 INFO - Return code: 0 11:02:08 INFO - grabbing minidump binary from tooltool 11:02:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:02:08 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27bfa90>, '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 0x2811f70>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28122e0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 11:02:08 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test-pgo/build 11:02:08 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 11:02:08 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 11:02:08 INFO - Return code: 0 11:02:08 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 11:02:08 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 11:02:08 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 11:02:08 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 11:02:08 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 11:02:08 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'B2G-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ympYqEcbRjyjKqcI_KLc1A/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-015', '--webServer', 'localhost'] in /builds/slave/test-pgo/build 11:02:08 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --debug --branchName B2G-Inbound --suite dromaeojs --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/ympYqEcbRjyjKqcI_KLc1A/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-015 --webServer localhost 11:02:08 INFO - Using env: {'DISPLAY': ':0', 11:02:08 INFO - 'HOME': '/home/cltbld', 11:02:08 INFO - 'LANG': 'en_US.UTF-8', 11:02:08 INFO - 'LANGUAGE': 'en_US:en', 11:02:08 INFO - 'LOGNAME': 'cltbld', 11:02:08 INFO - 'MAIL': '/var/mail/cltbld', 11:02:08 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 11:02:08 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 11:02:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:02:08 INFO - 'MOZ_NO_REMOTE': '1', 11:02:08 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 11:02:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:02:08 INFO - 'NO_EM_RESTART': '1', 11:02:08 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:02:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 11:02:08 INFO - 'PWD': '/builds/slave/test-pgo', 11:02:08 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 11:02:08 INFO - 'SHELL': '/bin/bash', 11:02:08 INFO - 'SHLVL': '1', 11:02:08 INFO - 'TERM': 'linux', 11:02:08 INFO - 'TMOUT': '86400', 11:02:08 INFO - 'USER': 'cltbld', 11:02:08 INFO - 'XDG_SESSION_COOKIE': '70a720fcaf18edea6683c2dc000001ad-1448302623.128361-1466739435', 11:02:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:02:08 INFO - '_': '/tools/buildbot/bin/python'} 11:02:08 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'B2G-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ympYqEcbRjyjKqcI_KLc1A/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-015', '--webServer', 'localhost'] with output_timeout 3600 11:02:09 INFO - mozversion INFO | application_buildid: 20151123083129 11:02:09 INFO - mozversion INFO | application_changeset: 23b800811e2438e2866889353c4e354da9ce0aa9 11:02:09 INFO - mozversion INFO | application_display_name: Nightly 11:02:09 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 11:02:09 INFO - mozversion INFO | application_name: Firefox 11:02:09 INFO - mozversion INFO | application_remotingname: firefox 11:02:09 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/b2g-inbound 11:02:09 INFO - mozversion INFO | application_vendor: Mozilla 11:02:09 INFO - mozversion INFO | application_version: 45.0a1 11:02:09 INFO - mozversion INFO | platform_buildid: 20151123083129 11:02:09 INFO - mozversion INFO | platform_changeset: 23b800811e2438e2866889353c4e354da9ce0aa9 11:02:09 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/b2g-inbound 11:02:09 INFO - mozversion INFO | platform_version: 45.0a1 11:02:09 INFO - 2015-11-23 11:02:09,028 DEBUG : using testdate: 1448305329 11:02:09 INFO - 2015-11-23 11:02:09,028 DEBUG : actual date: 1448305329 11:02:09 INFO - 2015-11-23 11:02:09,037 INFO : starting webserver on 'localhost:45744' 11:02:09 INFO - 2015-11-23 11:02:09,038 INFO : Starting test suite talos-linux64-ix-015 11:02:09 INFO - 2015-11-23 11:02:09,038 INFO : Starting test dromaeo_css 11:02:09 INFO - 2015-11-23 11:02:09,038 DEBUG : operating with platform_type : linux_ 11:02:09 INFO - 2015-11-23 11:02:09,039 INFO : Initialising browser for dromaeo_css test... 11:02:09 INFO - 2015-11-23 11:02:09,055 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpVc7KAW/profile http://localhost:45744/getInfo.html 11:02:13 INFO - 2015-11-23 11:02:13,321 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 11:02:13 INFO - 2015-11-23 11:02:13,321 DEBUG : BROWSER_OUTPUT: colorDepth:24 11:02:13 INFO - 2015-11-23 11:02:13,321 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 11:02:13 INFO - 2015-11-23 11:02:13,321 DEBUG : BROWSER_OUTPUT: __metrics 11:02:13 INFO - 2015-11-23 11:02:13,389 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 11:02:14 INFO - 2015-11-23 11:02:14,626 INFO : Browser initialized. 11:02:14 INFO - 2015-11-23 11:02:14,626 INFO : Running cycle 1/1 for dromaeo_css test... 11:02:14 INFO - 2015-11-23 11:02:14,626 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpVc7KAW/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 11:02:26 INFO - 2015-11-23 11:02:26,422 DEBUG : BROWSER_OUTPUT: RSS: Main: 140525568 11:02:26 INFO - 2015-11-23 11:02:26,422 DEBUG : BROWSER_OUTPUT: 11:03:17 INFO - 2015-11-23 11:03:17,218 DEBUG : BROWSER_OUTPUT: 1448305397217 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] 11:05:26 INFO - 2015-11-23 11:05:26,889 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45744/tests/dromaeo/cssquery-dojo.html (next: http://localhost:45744/tests/dromaeo/cssquery-ext.html) 11:05:28 INFO - 2015-11-23 11:05:28,135 DEBUG : BROWSER_OUTPUT: RSS: Main: 264839168 11:05:28 INFO - 2015-11-23 11:05:28,135 DEBUG : BROWSER_OUTPUT: 11:08:30 INFO - 2015-11-23 11:08:30,411 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45744/tests/dromaeo/cssquery-ext.html (next: http://localhost:45744/tests/dromaeo/cssquery-jquery.html) 11:08:30 INFO - 2015-11-23 11:08:30,972 DEBUG : BROWSER_OUTPUT: RSS: Main: 218353664 11:08:30 INFO - 2015-11-23 11:08:30,972 DEBUG : BROWSER_OUTPUT: 11:11:32 INFO - 2015-11-23 11:11:32,940 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45744/tests/dromaeo/cssquery-jquery.html (next: http://localhost:45744/tests/dromaeo/cssquery-mootools.html) 11:11:33 INFO - 2015-11-23 11:11:33,521 DEBUG : BROWSER_OUTPUT: RSS: Main: 213348352 11:11:33 INFO - 2015-11-23 11:11:33,521 DEBUG : BROWSER_OUTPUT: 11:14:35 INFO - 2015-11-23 11:14:35,477 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45744/tests/dromaeo/cssquery-mootools.html (next: http://localhost:45744/tests/dromaeo/cssquery-prototype.html) 11:14:36 INFO - 2015-11-23 11:14:36,046 DEBUG : BROWSER_OUTPUT: RSS: Main: 198483968 11:14:36 INFO - 2015-11-23 11:14:36,046 DEBUG : BROWSER_OUTPUT: 11:17:38 INFO - 2015-11-23 11:17:38,506 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45744/tests/dromaeo/cssquery-prototype.html (next: http://localhost:45744/tests/dromaeo/cssquery-yui.html) 11:17:39 INFO - 2015-11-23 11:17:39,072 DEBUG : BROWSER_OUTPUT: RSS: Main: 204816384 11:17:39 INFO - 2015-11-23 11:17:39,072 DEBUG : BROWSER_OUTPUT: 11:20:41 INFO - 2015-11-23 11:20:41,667 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45744/tests/dromaeo/cssquery-yui.html (next: http://localhost:45744/tests/dromaeo/cssquery-dojo.html) 11:20:41 INFO - 2015-11-23 11:20:41,917 DEBUG : BROWSER_OUTPUT: RSS: Main: 261406720 11:20:41 INFO - 2015-11-23 11:20:41,917 DEBUG : BROWSER_OUTPUT: 11:20:41 INFO - 2015-11-23 11:20:41,917 DEBUG : BROWSER_OUTPUT: __start_tp_report 11:20:41 INFO - 2015-11-23 11:20:41,917 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 11:20:41 INFO - 2015-11-23 11:20:41,918 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 11:20:41 INFO - 2015-11-23 11:20:41,918 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 11:20:41 INFO - 2015-11-23 11:20:41,919 DEBUG : BROWSER_OUTPUT: |0;dojo.html;3131.1545882611695;3227.080282119596;3249.707526322632;3261.9836900815494;3285.4907489339153;5215.269862219292;5321.547668448177;5359.249705041292;5400.648957817739;5419.512243898043;5337.2527846101575;5379.246905433232;5387.19192121181;5474.42518535553;5581.386047534768;4941.308216849644;4998.900021999558;5015.598752099823;5024.899502009957;5036.143855544567;5021.297018417425;5025.14572522672;5076.619253555979;5086.847394578169;5095.6942583444925;4837.806487740486;4846.854594362175;4914.533119353656;4938.9753051234875;4944.3572335596145;4914.877128071791;4916.680415772963;4920.138975679241;4934.506549345037;4959.231319145502;4612.86161415158;4889.3643826302705;4892.510748925079;4899.902001959977;4937.925931111036;5183.559397451221;5210.635255532115;5357.866053348697;5358.383785864637;5359.517643412073;5916.704164791743;5918.2306300181135;5920.585559010871;5922.940770592282;5923.822285331447;5817.56368272377;5922.970385148046;5962.284525856881;5967.283925928873;5970.223870896755;5416.945830541684;5461;5574.163875418639;5585.441455854382;5619.831405057773;5962.403759624003;6018.8194354169445;6023.367546407651;6024.548158888101;6041.969790151109;5767.567432442584;5769.942300577024;5771.711414429262;5772.740226689809;5784.045632470596;5570.220169176318;5745.712714364265;5830.679312637761;5890.410958904161;5945.346011938684;5799.739011744482;5847;5850.531957443394;5854.2096816930025;5861;5636.830895073154;5849.356570777211;5851.853703657357;5859;5870.236869206976;4491.438570178728;4509.0080182359825;4542.818287268538;4550.317452382103;4591.678582499259;3939.743916645466;3947.684185265229;3974.4435778990965;3990.20195960809;4072.6741860651077;5413.404525502192;5513.2005859150195;5520.834374968757;5522.6134170608475;5534.335879694382;5819.94180058194;5823.301203855564;5843.357230704619;5871.324797648325;5908.468237858613;5612.298462692163;5645.322561292671;5647.774089036392;5652;5654.46282603152;4957.3059771632;5051.62112841531;5136.357955255593;5160.716160611128;5193.974030129825;5996.67018313997;6032.276126864805;6080;6082.787102451482;6123.38766123393;5892;5966.105084237399;5969.791057312973;5971.522278217819;5971.701414929149;5774;5894.646321220741;6155.1075094112;6185.165002724574;6185.195924529782;5743.195952566561;5767.509761670305;5854.619449735754;5861.35525092248;5919.171316015675;5896.233489646319;5961.7615295387695;5971.671558064349;5973.790917317873;5976.432238937294;5632.521235694848;5748.338941021669;5782.624129431573;5819.679917604572;5836.970815145897;5709;5765.250517432707;5769.711514424346;5781.971090144522;5840.766369345179;5595.608307418442;5623.8875222496135;5624.775008999594;5627.803026894203;5628;5567.248421463212;5665.603407761417;5715.542756579381;5742.36833948257;5744.195812586325;5641.689707066151;5714.05718056516;5716.085426331767;5730.312362516524;5766.452187042224 11:20:41 INFO - 2015-11-23 11:20:41,920 DEBUG : BROWSER_OUTPUT: |1;ext.html;555.1866515554711;603.7222877476361;603.8369640197147;605.2192671453824;612.9111278864565;31898.521522177187;32560.511592326133;32573.348533029326;32578.511322330185;32598.185045373877;33229.169270768245;33301.33397332052;41016.79491602545;41711;41774.7911260444;8754.606042728092;8902.554872256362;8926.152015558511;8933;8946.194842464178;7738.148803631596;8571.22858942695;8658.956705216497;8659.220670139686;8662.826743465126;7708.3447906927695;7802.687892484294;10457.320274182191;10609.681709548688;10619.681409557727;10393.53229104692;10451.216158788122;10476.109530689824;10503.579856805718;10505.579776808918;7807.765767026998;10246.436445995467;10375.79248415035;10377;10377.325473844252;31360.37279254402;42707.78646106781;43677.34483982743;43756.56243437557;43832.78083609593;3411.846466908995;3660.5790334111653;3799.35410980134;3916.64750172483;4134.441850350195;29328.413431731246;29773.255668608243;29792;29897.402051959056;30432.087037388912;3711.4989476420606;3765.6046115157787;3774.226283611853;3868.6324799144036;3940.54683711374;238101;239015;239067.99999999825;239245;240260;57474.13788793171;57681.423185767606;57786;58073.70963145242;58149.4185058144;61297.69351153305;61493;61527.6923615388;61593.692031539555;61613.38386616166;14257.362387958261;14317.140971541741;14353.712925741427;14365.281735913162;14372.640683982983;10771.515281812337;10824.350538967687;10834.241603087708;10838.62064827743;10841.67474975752;19258.518537036685;20327.288544900857;20330.796692033186;20375.08312125958;20389.796102039087;7685.462017658822;7949.244821741925;7953.2842044216295;7999.240167163215;8045.0748163960725;924.2698268367914;961.4471678784587;986.413084214891;1027.3630349183554;1129.486083831871;28734.425311493655;28802.135935921957;28870.7112928868;28914;29196.854015729787;962.4081190068058;1039.4023436524028;1042.5829668132808;1049.5539395756773;1094.3379255550278;14249.50126745559;14292.225227635154;14689.92655036718;14888.851111488962;14937.878652665891;309887;313822;314066;314093;314319;45028.3245751314;46002;51055.23417148746;52041.47958520366;52270;1327.3164320375015;1332.4670131947298;1339.1161833190047;1363.2093385836192;1365.911215770952;25664.743352566235;27986.580201297405;28890.711092888803;29196.416071678872;29746;49055.509444905096;49463;49552.752236238586;49670.50329496659;49690.254646179616;267958;269554;270090.84591193835;270108;270186;30253.243668908453;30467.496237932035;30605.23486912845;30708.692913070583;30787.846060769552;41762;42559.3616095765;42577.57422425736;42871;43292.35061474017;36862.44706329461;37146;37596.436053459765;38140.23719525649;38163.42754858735;35655.82172089123;36622.450663240605;37330.6266937338;37559.62440375561;37679.24641507209;35711.64288357187;36333;36540.0864978367;36557.817210914836;36623.26753464969;31942.041738747874;33014.33971320512;33203;33569.66430335665;33932;25543.87228063922;26538.469230614894;26619.866900665373;26954.09723226692;27118.457630847668 11:20:41 INFO - 2015-11-23 11:20:41,921 DEBUG : BROWSER_OUTPUT: |2;jquery.html;353.6233910884909;360.6411620437665;361.36399936112434;363.62546577025654;364.19331181433125;14146.64633384166;14296.928515357435;16432.753508697366;16736.748948765762;17396.565085872877;15897.52307430779;16014.43949461769;16190.595235119099;16739.91630041851;16747.497575072735;5168.069747445458;5304.681719096867;5309.097453432925;5309.469053094698;5313.760880760375;3947;4071.9389209161886;5249.86875328116;5290.973545132289;5861.120831875211;5894;5920.88158236835;5940.34656187819;5943.732532036069;5946.762129514815;5760.337561180476;5830.970845145789;5842.036064049448;5848.736806843703;5899.174115623816;5205.479452054764;5220.660657057279;5223.242629818693;5235.240890070956;5236.319278493771;11874.228175168586;12234.08244381675;20683;21418;21437;2111.345482900306;2215.4793623498463;2230.9888450557805;2316.525112351964;2615.6730408698913;9498.477583732893;9645.373050751748;10109.797804043952;10557.208209384327;12839.1012629116;1815.301109073003;1842.0973722875694;1868.8037756035556;1910.9808901910942;1997.4007797660788;59974;61306.69346653238;61585.91761947388;62383.688081559754;62867.371326287066;10273.332233404804;10341.9482902585;10404.895951040544;10452.059314661718;10505.789884202273;13634.1137826041;13637.727245455035;13644.181349119084;13659.658508537168;13699.904007679363;7603.885941710879;7614.200508946592;7634.885476717854;7690.192529784404;7740.845183096307;7661.387089032864;7667.731629392944;7671.041119860018;7700.268474494914;7705.922940770521;4412.889677758082;4463.330500424962;4485.41689580359;4497.617702495325;4515.2324104902245;1720.8451239388264;1739.478156553029;1749.3177660712333;1765.9028753418686;1774.4587900690155;548.8134034428314;859.2739135430551;886.9822603547893;964.3249231012622;973.9902600974041;16480.505584832234;16722.24749886258;17015.404460843813;17310.82689173092;17415.216315265843;828.1614815110445;926.4533924984291;928.9210417114621;980.9509524523745;989.248171389749;9473.242140628734;9734.880488743886;9813.656522021694;9844.409335439897;9962.452065136487;365242;374317;438781;478984;479060;39748;58717.11924321139;76417;82032;84314.57842710747;1113.154002957758;1124.0333313350511;1134.8014097532898;1143.656902929118;1148.3741360958297;11327.773444530898;15002.249887505362;15384.84615153834;15912.840871591136;16195.38046195371;32791.34417311688;34525;34548.654513454545;34967.82516087403;35344.64655353517;44124.33813492736;44915.32627010663;45296.547034529234;46549.767251163525;47061.76469117632;9819.558119884765;9873.259505537257;10015.69952901414;10024.899751002396;10131.08820206185;15250.694986100438;17065.573360666083;17408.953433149403;17945.371911983017;18038.909805451414;13946.721065578835;14336.49822256216;14349.426022958965;14784.11295322284;14932.328045237773;14354.425822966965;14418.13491190532;14549.563513094625;14848.554543363716;14853.851461485247;13784.655383615489;13908.37412316428;14923.477678281208;15066.397344106552;15230.162341071347;9041.367104302635;9685.951570242385;9767.902320976984;9903;9930.453825039693;10277.075063244343;10776;13651.180929144282;14762.926185369004;15123.092614443169 11:20:41 INFO - 2015-11-23 11:20:41,923 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1519.240379810095;1650.8679305655548;1680.6638672265549;1722.2422134260933;1738.956526086848;6748.730050797968;7362.116546014479;7515.173330933607;7518.323350898411;7557.735479258227;7399.223081576438;7512.699492020326;7518.699252029912;7519.6616152273145;7520.511166774156;1965.8820470771727;2003.6894281386408;2004.8897310647908;2271.432141964509;2274.624686926655;2241.0923575951765;2296.9655455168186;2301.7698230177016;2302.5855346037706;2303.1938821412455;2182.3998400439928;2198.39544125366;2243.955120897581;2245.135622785223;2248.898799554024;1948.103872218774;1980.8316293115101;1982.345825877457;2164.166795783635;2216.8004879560835;2192.572448372568;2240.372695645222;2240.451089483071;2240.7423146338215;2241.8991145398495;7470.58911759853;7509.324160825552;7526.8118297042465;7530.774076777706;7535.510191837513;4498.437695288089;4614.2617181250835;4615.399998000272;4618.468876079261;4621.237495813187;2958.6301712285963;2993.82037077776;3062.1579065756873;3066.432709948667;3089.891853785129;972.2659392158945;1007.2697739833176;1011.7622358745689;1011.9342242754198;1012.0688966151158;10233.181345492343;10258.487075646262;10264.743381415376;10266.486675666187;10270.07569318765;4056.59434056592;4124.608162224584;4149.33610622299;4165.645920096826;4178.707490475637;8820.294376449869;8830.42602230853;8847.336449766293;8848.823023539493;8882.245009174163;4574.313852922089;4585.151746926829;4585.679002469795;4588.105319462739;4588.357629931812;4151.356539736345;4155.854545090907;4170.979145104255;4171.916561668811;4176.164767046603;3625.691816195653;3629.709623230188;3633.4004889193516;3649.50731651229;3678.411454167374;1226.5952235762177;1233.6052463211865;1235.7034311765112;1241.76406482768;1244.7510497900457;978.9951050244703;1050.894910508943;1170.9473073711704;1213.1447329632588;1215.5380955236953;6818.4886133540185;6846.110005699227;6903.75836845708;6920.342567456084;6924.169099708067;1122.528538014036;1123.9325640461598;1126.5043380912373;1127.8308253761838;1144.187626784992;5326.760295786699;5491.7254137292975;5839.824805255849;5931.851703707442;5947.286325640951;8870.64517419296;8926.419782714103;9063;9088.636454541876;9206.769830754285;8957.955210224038;9099.590518426554;9114.58984345706;9118.088191180828;9123.771905702279;6785.830354241183;6993.545419547713;7011.228764835966;7150.892736608955;7159.069320988238;7045.189803172496;7070.04554385172;7086.185088714864;7092.787216383516;7099.787006389816;7615.276548727862;7829.6085195741125;7966.3626909848235;7986.520808751494;7990.320822730133;7866.528008319519;7961.243681850215;8219.301359384519;8223.794405139919;8228.465149765247;6779.050932869501;6801.625910574966;6889.931100688929;6891.793246202622;6905.620190889549;7315.6342182889575;7390.9260907390235;7394.149672787698;7409.073865766779;7420.220876807857;6885.104936358442;6985.44116470671;7009.579425234502;7032.085828842218;7045.295470452914;6895.5173137881875;6909.7581584644295;6954.408875245458;7010.719571217298;7013.438924886099;6593.3736295051895;6634.966825165843;6666.600003999775;6672.065910772399;6685.866282674417;6164.643778368752;6167;6172.321044684992;6219.844503887439;6226.40849119333;5708.172315014383;5808.419158084158;6048.60684055535;6098.817035488943;6101.328853826164 11:20:41 INFO - 2015-11-23 11:20:41,923 DEBUG : BROWSER_OUTPUT: |4;prototype.html;323.2065279738243;325.5556165833637;329.73621103117506;331.9004298710388;334.0812764896535;5877.059670452729;6004.639721616706;6024.819255422333;6030.608010479315;6118.296395914465;5849.912251316223;5942.792002279921;5963.701814909259;5968.462838344548;5978.850528736783;4599.793009314572;4605.194091034073;4605.9769701151445;4615.584597386234;4618.907621847561;4394.450693663292;4486.618637415823;4503.279475283955;4619.16854966106;4624.237000894848;4565.543445655425;4568.5431456854385;4582.243929751587;4599.44806623204;4609.516000819899;4570.520095389969;4581.473130589975;4582.977085114587;4598.655100867431;4599;4012.578679238696;4018.1361007383553;4019.3970904364287;4019.738716983416;4028.3353246714255;5560.443955604448;5677.460641239076;5686.2039314496005;5695.686737229451;5699.857503562403;5300.814471493479;5302.231176479428;5304.17785243284;5307.708076055816;5308;6139.201903752528;6359.077933699587;6366.586171898812;6368.777092801776;6371.52213583983;4282.272013757669;4296;4354.673399495051;4360.324149756792;4374.650027997753;6552.148220731275;6562.310957349505;6575.243846957614;6603.867922641521;6634.701438435282;4449.888752781141;4450.488193857748;4453.109378124388;4453.4433195850515;4457.086297309044;4419.18245124653;4509;4509.391232183679;4514.571115743999;4531.025829446685;5248.685078895279;5258.7370631468275;5262.473752624784;5264.236685680631;5266.078436273637;6403.935960640427;6411.326810684905;6416.326285740023;6419.903701444482;6421.2615549211505;1572.080333005182;1579.336678594993;1580.3678528588428;1580.8182059063124;1580.8814338924626;1031.3141760729181;1056.9048785609332;1057.360297020307;1057.5293994172519;1062.054771253585;6180.351063138396;6181.350958149419;6184.938150618526;6188.907166392508;6192.783252586138;6529.2817790043055;6542.574732642363;6585.5719378240265;6588.8352791180605;6607.603543787388;6045.546584006217;6157.876842463125;6180.598261113013;6186.845328866814;6190.473809726133;3560.537130173061;3576.7853928764357;3576.8554062699686;3578.4632305154437;3579.1231148368815;6798.898016529756;6819.931800681929;6821.3519715626935;6830.59016459014;6835.248122706498;6583.144191255106;6719.092922455504;6722.058911752359;6727.529072964846;6742.292059333699;6801.897971530431;6803.319668033157;6805.829854253584;6806.829829254309;6810.421114205348;6389.744410223539;6540.869182616226;6575.80272591823;6581.243157036811;6585.111010013587;6434.485241180788;6547.836304092436;6582.80251592453;6583.374579414948;6599.8020059398295;6832.111825462658;6843.315668433117;6850.177978642595;6863;6870.519063665495;4400.823967041282;4493.258612328929;4493.77531123436;4496.39298694672;4496.685232033727;6571.769988050395;6579.078928950046;6602.6698665067515;6607.9669601651685;6624.370684784938;6421.775237866652;6423.197100362455;6424.646644434601;6431.903521447276;6441.711657668391;6300.779472718433;6375.107484952203;6417.518686098468;6454.741810327534;6458.7093580789915;6297.370262973666;6302.275238347649;6309.305976342507;6318.08387783778;6321;6473.935260647521;6474.093626892145;6479.676016199077;6480.6435646038035;6487.3836985486305;6188;6315.242170939517;6322.589031712924;6328.873422531431;6344.429001389897 11:20:41 INFO - 2015-11-23 11:20:41,924 DEBUG : BROWSER_OUTPUT: |5;yui.html;777.1606664802015;838.513662075996;851.897772267328;853.7097386888456;859.6088779605278;13029;13508.662283442918;13526.188428694286;13541.729165416698;13549.254790986504;10765.569377224921;13200.603981880535;13237.669058273525;13253.204807711543;13306;658.4041442494538;787.1577412168981;810.3436216664492;815.233680340481;816.0330008939426;799.8120441696196;804.5936801915054;813.0812182234067;814.1329484099415;815.7838172884191;689.7068745783047;696.053367420308;831.1729828820332;834.2325060943916;834.8747687846841;826.6775957376628;841.247083859948;845.18439705684;848.1094850407048;849.762066621347;614.5605891787349;618.9907151392732;623.9438450539474;623.9469645080128;624.3849807939176;13034.739305213938;13292.335383230897;13294.800577991338;13321.40053697586;13325.933370333183;11864.644060678194;12542.24746515203;12697.555585554554;13060.673483162902;13150.408231629504;10300.442046901911;10395.94802025985;10477.161827053817;10572.52423640938;10793.136549076055;3636.3999940009867;3650.3611867923273;3655;3733.775973441575;3830.2722482728473;44590.10819783618;44879.55120448819;45021.549784502065;45586.08827823425;45916.08167836658;10138.594456221816;10194.01216762739;10320.793584128276;10433.791324173473;10481.109105726098;18513.7222941656;18568.535786605444;18580.349687760863;18583.16375763094;18637.068146592617;7437.405007599487;7495.925040749523;7677.0403699537555;7744.070711514654;7804.024496937883;4405.273129933589;4407.471103467605;4438.223310920576;4507.616852567503;4516.209663308973;3027.04648035868;3052.786304958676;3054.679258677851;3071.600691910082;3076.1079287006964;545.8276061276064;548.3858078951599;553.3967974907371;556.4046470276764;565.6436445039599;594.8393933637893;624.8625302433458;627.3820287017285;644.6003477843767;644.6132320607692;7512;7567.167611562723;7657.234276572298;7880.330171935335;7920.564368959763;534.3000669123461;642.877853207889;649.5900210220136;651.1437459740521;652.9347065293433;3693;3814.136371964983;3954.7231693781737;3970.404439334065;4105.158442519277;54813.451865481635;56426;57583.424165758646;57640.71179644159;57751;50220;50802.23796643053;51921;51940.74029629903;52248.477515225124;45558;45884.082318353445;46715.5328446718;46722.065558688635;47387.76306118447;8325.209105135002;8460.53467059293;8560.700375486827;8569;8725;35171;35634.64365356313;36169.81915090408;37034.44448333331;37145.07137321481;44631.776841115585;44664.55335446604;44919;45320.093598128515;45841.54158458373;11361.37512436824;11416.771664566828;11493.310401375944;11517.82723259135;11704.824427633423;12379.69050773738;12495.312757798409;12594.685132871751;12609.747805044031;12666.43001064936;10492.265541412333;10768.784624307627;10775.030247277782;10947.616833410792;11300.94349528247;11636.825447618461;11929.105317101426;11981.341026243641;12250.142490025613;12396.504139834306;10916.50875710579;10924.672259832218;10940.671779846618;11271.211015229183;11327.546898123983;9853.612309533846;10130.341527800669;10173.643922462974;10251.692449226535;10842.620508282173;8426.241638252586;8534.957325213334;8559.186877246651;8806.295496360404;9689.370190937567 11:20:41 INFO - 2015-11-23 11:20:41,924 DEBUG : BROWSER_OUTPUT: __end_tp_report 11:20:41 INFO - 2015-11-23 11:20:41,924 DEBUG : BROWSER_OUTPUT: __start_cc_report 11:20:41 INFO - 2015-11-23 11:20:41,924 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,1021 11:20:41 INFO - 2015-11-23 11:20:41,924 DEBUG : BROWSER_OUTPUT: __end_cc_report 11:20:41 INFO - 2015-11-23 11:20:41,925 DEBUG : BROWSER_OUTPUT: __startTimestamp1448306441916__endTimestamp 11:20:41 INFO - 2015-11-23 11:20:41,925 DEBUG : BROWSER_OUTPUT: 11:20:41 INFO - 2015-11-23 11:20:41,925 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 11:20:41 INFO - 2015-11-23 11:20:41,925 DEBUG : BROWSER_OUTPUT: Number of tests: 6 11:20:41 INFO - 2015-11-23 11:20:41,925 DEBUG : BROWSER_OUTPUT: 11:20:41 INFO - 2015-11-23 11:20:41,925 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:5444.68 Median:5647.77 stddev:622.66 (11.0%) stddev-sans-first:597.53 11:20:41 INFO - 2015-11-23 11:20:41,925 DEBUG : BROWSER_OUTPUT: Values: 3131.2 3227.1 3249.7 3262.0 3285.5 5215.3 5321.5 5359.2 5400.6 5419.5 5337.3 5379.2 5387.2 5474.4 5581.4 4941.3 4998.9 5015.6 5024.9 5036.1 5021.3 5025.1 5076.6 5086.8 5095.7 4837.8 4846.9 4914.5 4939.0 4944.4 4914.9 4916.7 4920.1 4934.5 4959.2 4612.9 4889.4 4892.5 4899.9 4937.9 5183.6 5210.6 5357.9 5358.4 5359.5 5916.7 5918.2 5920.6 5922.9 5923.8 5817.6 5923.0 5962.3 5967.3 5970.2 5416.9 5461.0 5574.2 5585.4 5619.8 5962.4 6018.8 6023.4 6024.5 6042.0 5767.6 5769.9 5771.7 5772.7 5784.0 5570.2 5745.7 5830.7 5890.4 5945.3 5799.7 5847.0 5850.5 5854.2 5861.0 5636.8 5849.4 5851.9 5859.0 5870.2 4491.4 4509.0 4542.8 4550.3 4591.7 3939.7 3947.7 3974.4 3990.2 4072.7 5413.4 5513.2 5520.8 5522.6 5534.3 5819.9 5823.3 5843.4 5871.3 5908.5 5612.3 5645.3 5647.8 5652.0 5654.5 4957.3 5051.6 5136.4 5160.7 5194.0 5996.7 6032.3 6080.0 6082.8 6123.4 5892.0 5966.1 5969.8 5971.5 5971.7 5774.0 5894.6 6155.1 6185.2 6185.2 5743.2 5767.5 5854.6 5861.4 5919.2 5896.2 5961.8 5971.7 5973.8 5976.4 5632.5 5748.3 5782.6 5819.7 5837.0 5709.0 5765.3 5769.7 5782.0 5840.8 5595.6 5623.9 5624.8 5627.8 5628.0 5567.2 5665.6 5715.5 5742.4 5744.2 5641.7 5714.1 5716.1 5730.3 5766.5 11:20:41 INFO - 2015-11-23 11:20:41,925 DEBUG : BROWSER_OUTPUT: 11:20:41 INFO - 2015-11-23 11:20:41,926 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:44697.00 Median:33108.67 stddev:71883.12 (217.1%) stddev-sans-first:72008.36 11:20:41 INFO - 2015-11-23 11:20:41,927 DEBUG : BROWSER_OUTPUT: Values: 555.2 603.7 603.8 605.2 612.9 31898.5 32560.5 32573.3 32578.5 32598.2 33229.2 33301.3 41016.8 41711.0 41774.8 8754.6 8902.6 8926.2 8933.0 8946.2 7738.1 8571.2 8659.0 8659.2 8662.8 7708.3 7802.7 10457.3 10609.7 10619.7 10393.5 10451.2 10476.1 10503.6 10505.6 7807.8 10246.4 10375.8 10377.0 10377.3 31360.4 42707.8 43677.3 43756.6 43832.8 3411.8 3660.6 3799.4 3916.6 4134.4 29328.4 29773.3 29792.0 29897.4 30432.1 3711.5 3765.6 3774.2 3868.6 3940.5 238101.0 239015.0 239068.0 239245.0 240260.0 57474.1 57681.4 57786.0 58073.7 58149.4 61297.7 61493.0 61527.7 61593.7 61613.4 14257.4 14317.1 14353.7 14365.3 14372.6 10771.5 10824.4 10834.2 10838.6 10841.7 19258.5 20327.3 20330.8 20375.1 20389.8 7685.5 7949.2 7953.3 7999.2 8045.1 924.3 961.4 986.4 1027.4 1129.5 28734.4 28802.1 28870.7 28914.0 29196.9 962.4 1039.4 1042.6 1049.6 1094.3 14249.5 14292.2 14689.9 14888.9 14937.9 309887.0 313822.0 314066.0 314093.0 314319.0 45028.3 46002.0 51055.2 52041.5 52270.0 1327.3 1332.5 1339.1 1363.2 1365.9 25664.7 27986.6 28890.7 29196.4 29746.0 49055.5 49463.0 49552.8 49670.5 49690.3 267958.0 269554.0 270090.8 270108.0 270186.0 30253.2 30467.5 30605.2 30708.7 30787.8 41762.0 42559.4 42577.6 42871.0 43292.4 36862.4 37146.0 37596.4 38140.2 38163.4 35655.8 36622.5 37330.6 37559.6 37679.2 35711.6 36333.0 36540.1 36557.8 36623.3 31942.0 33014.3 33203.0 33569.7 33932.0 25543.9 26538.5 26619.9 26954.1 27118.5 11:20:41 INFO - 2015-11-23 11:20:41,927 DEBUG : BROWSER_OUTPUT: 11:20:41 INFO - 2015-11-23 11:20:41,927 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:25345.83 Median:17849.13 stddev:70379.25 (394.3%) stddev-sans-first:70551.66 11:20:41 INFO - 2015-11-23 11:20:41,927 DEBUG : BROWSER_OUTPUT: Values: 353.6 360.6 361.4 363.6 364.2 14146.6 14296.9 16432.8 16736.7 17396.6 15897.5 16014.4 16190.6 16739.9 16747.5 5168.1 5304.7 5309.1 5309.5 5313.8 3947.0 4071.9 5249.9 5291.0 5861.1 5894.0 5920.9 5940.3 5943.7 5946.8 5760.3 5831.0 5842.0 5848.7 5899.2 5205.5 5220.7 5223.2 5235.2 5236.3 11874.2 12234.1 20683.0 21418.0 21437.0 2111.3 2215.5 2231.0 2316.5 2615.7 9498.5 9645.4 10109.8 10557.2 12839.1 1815.3 1842.1 1868.8 1911.0 1997.4 59974.0 61306.7 61585.9 62383.7 62867.4 10273.3 10341.9 10404.9 10452.1 10505.8 13634.1 13637.7 13644.2 13659.7 13699.9 7603.9 7614.2 7634.9 7690.2 7740.8 7661.4 7667.7 7671.0 7700.3 7705.9 4412.9 4463.3 4485.4 4497.6 4515.2 1720.8 1739.5 1749.3 1765.9 1774.5 548.8 859.3 887.0 964.3 974.0 16480.5 16722.2 17015.4 17310.8 17415.2 828.2 926.5 928.9 981.0 989.2 9473.2 9734.9 9813.7 9844.4 9962.5 365242.0 374317.0 438781.0 478984.0 479060.0 39748.0 58717.1 76417.0 82032.0 84314.6 1113.2 1124.0 1134.8 1143.7 1148.4 11327.8 15002.2 15384.8 15912.8 16195.4 32791.3 34525.0 34548.7 34967.8 35344.6 44124.3 44915.3 45296.5 46549.8 47061.8 9819.6 9873.3 10015.7 10024.9 10131.1 15250.7 17065.6 17409.0 17945.4 18038.9 13946.7 14336.5 14349.4 14784.1 14932.3 14354.4 14418.1 14549.6 14848.6 14853.9 13784.7 13908.4 14923.5 15066.4 15230.2 9041.4 9686.0 9767.9 9903.0 9930.5 10277.1 10776.0 13651.2 14762.9 15123.1 11:20:41 INFO - 2015-11-23 11:20:41,927 DEBUG : BROWSER_OUTPUT: 11:20:41 INFO - 2015-11-23 11:20:41,927 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5289.85 Median:6073.71 stddev:2702.82 (44.5%) stddev-sans-first:2695.54 11:20:41 INFO - 2015-11-23 11:20:41,929 DEBUG : BROWSER_OUTPUT: Values: 1519.2 1650.9 1680.7 1722.2 1739.0 6748.7 7362.1 7515.2 7518.3 7557.7 7399.2 7512.7 7518.7 7519.7 7520.5 1965.9 2003.7 2004.9 2271.4 2274.6 2241.1 2297.0 2301.8 2302.6 2303.2 2182.4 2198.4 2244.0 2245.1 2248.9 1948.1 1980.8 1982.3 2164.2 2216.8 2192.6 2240.4 2240.5 2240.7 2241.9 7470.6 7509.3 7526.8 7530.8 7535.5 4498.4 4614.3 4615.4 4618.5 4621.2 2958.6 2993.8 3062.2 3066.4 3089.9 972.3 1007.3 1011.8 1011.9 1012.1 10233.2 10258.5 10264.7 10266.5 10270.1 4056.6 4124.6 4149.3 4165.6 4178.7 8820.3 8830.4 8847.3 8848.8 8882.2 4574.3 4585.2 4585.7 4588.1 4588.4 4151.4 4155.9 4171.0 4171.9 4176.2 3625.7 3629.7 3633.4 3649.5 3678.4 1226.6 1233.6 1235.7 1241.8 1244.8 979.0 1050.9 1170.9 1213.1 1215.5 6818.5 6846.1 6903.8 6920.3 6924.2 1122.5 1123.9 1126.5 1127.8 1144.2 5326.8 5491.7 5839.8 5931.9 5947.3 8870.6 8926.4 9063.0 9088.6 9206.8 8958.0 9099.6 9114.6 9118.1 9123.8 6785.8 6993.5 7011.2 7150.9 7159.1 7045.2 7070.0 7086.2 7092.8 7099.8 7615.3 7829.6 7966.4 7986.5 7990.3 7866.5 7961.2 8219.3 8223.8 8228.5 6779.1 6801.6 6889.9 6891.8 6905.6 7315.6 7390.9 7394.1 7409.1 7420.2 6885.1 6985.4 7009.6 7032.1 7045.3 6895.5 6909.8 6954.4 7010.7 7013.4 6593.4 6635.0 6666.6 6672.1 6685.9 6164.6 6167.0 6172.3 6219.8 6226.4 5708.2 5808.4 6048.6 6098.8 6101.3 11:20:41 INFO - 2015-11-23 11:20:41,929 DEBUG : BROWSER_OUTPUT: 11:20:41 INFO - 2015-11-23 11:20:41,929 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:5328.00 Median:6128.75 stddev:1620.74 (26.4%) stddev-sans-first:1581.16 11:20:41 INFO - 2015-11-23 11:20:41,929 DEBUG : BROWSER_OUTPUT: Values: 323.2 325.6 329.7 331.9 334.1 5877.1 6004.6 6024.8 6030.6 6118.3 5849.9 5942.8 5963.7 5968.5 5978.9 4599.8 4605.2 4606.0 4615.6 4618.9 4394.5 4486.6 4503.3 4619.2 4624.2 4565.5 4568.5 4582.2 4599.4 4609.5 4570.5 4581.5 4583.0 4598.7 4599.0 4012.6 4018.1 4019.4 4019.7 4028.3 5560.4 5677.5 5686.2 5695.7 5699.9 5300.8 5302.2 5304.2 5307.7 5308.0 6139.2 6359.1 6366.6 6368.8 6371.5 4282.3 4296.0 4354.7 4360.3 4374.7 6552.1 6562.3 6575.2 6603.9 6634.7 4449.9 4450.5 4453.1 4453.4 4457.1 4419.2 4509.0 4509.4 4514.6 4531.0 5248.7 5258.7 5262.5 5264.2 5266.1 6403.9 6411.3 6416.3 6419.9 6421.3 1572.1 1579.3 1580.4 1580.8 1580.9 1031.3 1056.9 1057.4 1057.5 1062.1 6180.4 6181.4 6184.9 6188.9 6192.8 6529.3 6542.6 6585.6 6588.8 6607.6 6045.5 6157.9 6180.6 6186.8 6190.5 3560.5 3576.8 3576.9 3578.5 3579.1 6798.9 6819.9 6821.4 6830.6 6835.2 6583.1 6719.1 6722.1 6727.5 6742.3 6801.9 6803.3 6805.8 6806.8 6810.4 6389.7 6540.9 6575.8 6581.2 6585.1 6434.5 6547.8 6582.8 6583.4 6599.8 6832.1 6843.3 6850.2 6863.0 6870.5 4400.8 4493.3 4493.8 4496.4 4496.7 6571.8 6579.1 6602.7 6608.0 6624.4 6421.8 6423.2 6424.6 6431.9 6441.7 6300.8 6375.1 6417.5 6454.7 6458.7 6297.4 6302.3 6309.3 6318.1 6321.0 6473.9 6474.1 6479.7 6480.6 6487.4 6188.0 6315.2 6322.6 6328.9 6344.4 11:20:41 INFO - 2015-11-23 11:20:41,929 DEBUG : BROWSER_OUTPUT: 11:20:41 INFO - 2015-11-23 11:20:41,929 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:13757.17 Median:44899.28 stddev:15824.60 (35.2%) stddev-sans-first:15838.98 11:20:41 INFO - 2015-11-23 11:20:41,929 DEBUG : BROWSER_OUTPUT: Values: 777.2 838.5 851.9 853.7 859.6 13029.0 13508.7 13526.2 13541.7 13549.3 10765.6 13200.6 13237.7 13253.2 13306.0 658.4 787.2 810.3 815.2 816.0 799.8 804.6 813.1 814.1 815.8 689.7 696.1 831.2 834.2 834.9 826.7 841.2 845.2 848.1 849.8 614.6 619.0 623.9 623.9 624.4 13034.7 13292.3 13294.8 13321.4 13325.9 11864.6 12542.2 12697.6 13060.7 13150.4 10300.4 10395.9 10477.2 10572.5 10793.1 3636.4 3650.4 3655.0 3733.8 3830.3 44590.1 44879.6 45021.5 45586.1 45916.1 10138.6 10194.0 10320.8 10433.8 10481.1 18513.7 18568.5 18580.3 18583.2 18637.1 7437.4 7495.9 7677.0 7744.1 7804.0 4405.3 4407.5 4438.2 4507.6 4516.2 3027.0 3052.8 3054.7 3071.6 3076.1 545.8 548.4 553.4 556.4 565.6 594.8 624.9 627.4 644.6 644.6 7512.0 7567.2 7657.2 7880.3 7920.6 534.3 642.9 649.6 651.1 652.9 3693.0 3814.1 3954.7 3970.4 4105.2 54813.5 56426.0 57583.4 57640.7 57751.0 50220.0 50802.2 51921.0 51940.7 52248.5 45558.0 45884.1 46715.5 46722.1 47387.8 8325.2 8460.5 8560.7 8569.0 8725.0 35171.0 35634.6 36169.8 37034.4 37145.1 44631.8 44664.6 44919.0 45320.1 45841.5 11361.4 11416.8 11493.3 11517.8 11704.8 12379.7 12495.3 12594.7 12609.7 12666.4 10492.3 10768.8 10775.0 10947.6 11300.9 11636.8 11929.1 11981.3 12250.1 12396.5 10916.5 10924.7 10940.7 11271.2 11327.5 9853.6 10130.3 10173.6 10251.7 10842.6 8426.2 8535.0 8559.2 8806.3 9689.4 11:20:41 INFO - 2015-11-23 11:20:41,929 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 11:20:41 INFO - 2015-11-23 11:20:41,930 DEBUG : BROWSER_OUTPUT: 11:20:42 INFO - 2015-11-23 11:20:42,514 INFO : Browser exited with error code: 0 11:20:42 INFO - 2015-11-23 11:20:42,530 INFO : Completed test dromaeo_css (00:18:33) 11:20:42 INFO - 2015-11-23 11:20:42,530 INFO : Starting test kraken 11:20:42 INFO - 2015-11-23 11:20:42,530 DEBUG : operating with platform_type : linux_ 11:20:42 INFO - 2015-11-23 11:20:42,530 INFO : Initialising browser for kraken test... 11:20:42 INFO - 2015-11-23 11:20:42,536 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpo5S7Es/profile http://localhost:45744/getInfo.html 11:20:46 INFO - 2015-11-23 11:20:46,533 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 11:20:46 INFO - 2015-11-23 11:20:46,533 DEBUG : BROWSER_OUTPUT: colorDepth:24 11:20:46 INFO - 2015-11-23 11:20:46,533 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 11:20:46 INFO - 2015-11-23 11:20:46,533 DEBUG : BROWSER_OUTPUT: __metrics 11:20:46 INFO - 2015-11-23 11:20:46,698 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 11:20:47 INFO - 2015-11-23 11:20:47,956 INFO : Browser initialized. 11:20:47 INFO - 2015-11-23 11:20:47,956 INFO : Running cycle 1/1 for kraken test... 11:20:47 INFO - 2015-11-23 11:20:47,956 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpo5S7Es/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 11:20:59 INFO - 2015-11-23 11:20:59,761 DEBUG : BROWSER_OUTPUT: RSS: Main: 139939840 11:20:59 INFO - 2015-11-23 11:20:59,761 DEBUG : BROWSER_OUTPUT: 11:21:02 INFO - 2015-11-23 11:21:02,216 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45744/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:45744/tests/kraken/driver.html?testName=audio-beat-detection) 11:21:02 INFO - 2015-11-23 11:21:02,797 DEBUG : BROWSER_OUTPUT: RSS: Main: 177373184 11:21:02 INFO - 2015-11-23 11:21:02,798 DEBUG : BROWSER_OUTPUT: 11:21:05 INFO - 2015-11-23 11:21:05,394 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45744/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:45744/tests/kraken/driver.html?testName=audio-dft) 11:21:05 INFO - 2015-11-23 11:21:05,963 DEBUG : BROWSER_OUTPUT: RSS: Main: 169246720 11:21:05 INFO - 2015-11-23 11:21:05,963 DEBUG : BROWSER_OUTPUT: 11:21:08 INFO - 2015-11-23 11:21:08,869 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45744/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:45744/tests/kraken/driver.html?testName=audio-fft) 11:21:09 INFO - 2015-11-23 11:21:09,431 DEBUG : BROWSER_OUTPUT: RSS: Main: 152231936 11:21:09 INFO - 2015-11-23 11:21:09,431 DEBUG : BROWSER_OUTPUT: 11:21:11 INFO - 2015-11-23 11:21:11,388 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45744/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:45744/tests/kraken/driver.html?testName=audio-oscillator) 11:21:11 INFO - 2015-11-23 11:21:11,949 DEBUG : BROWSER_OUTPUT: RSS: Main: 154431488 11:21:11 INFO - 2015-11-23 11:21:11,949 DEBUG : BROWSER_OUTPUT: 11:21:14 INFO - 2015-11-23 11:21:14,110 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45744/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:45744/tests/kraken/driver.html?testName=imaging-gaussian-blur) 11:21:14 INFO - 2015-11-23 11:21:14,683 DEBUG : BROWSER_OUTPUT: RSS: Main: 156856320 11:21:14 INFO - 2015-11-23 11:21:14,683 DEBUG : BROWSER_OUTPUT: 11:21:17 INFO - 2015-11-23 11:21:17,554 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45744/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:45744/tests/kraken/driver.html?testName=imaging-darkroom) 11:21:18 INFO - 2015-11-23 11:21:18,128 DEBUG : BROWSER_OUTPUT: RSS: Main: 157028352 11:21:18 INFO - 2015-11-23 11:21:18,128 DEBUG : BROWSER_OUTPUT: 11:21:21 INFO - 2015-11-23 11:21:21,500 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45744/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:45744/tests/kraken/driver.html?testName=imaging-desaturate) 11:21:22 INFO - 2015-11-23 11:21:22,074 DEBUG : BROWSER_OUTPUT: RSS: Main: 156483584 11:21:22 INFO - 2015-11-23 11:21:22,075 DEBUG : BROWSER_OUTPUT: 11:21:24 INFO - 2015-11-23 11:21:24,832 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45744/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:45744/tests/kraken/driver.html?testName=json-parse-financial) 11:21:25 INFO - 2015-11-23 11:21:25,419 DEBUG : BROWSER_OUTPUT: RSS: Main: 155619328 11:21:25 INFO - 2015-11-23 11:21:25,420 DEBUG : BROWSER_OUTPUT: 11:21:26 INFO - 2015-11-23 11:21:26,989 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45744/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:45744/tests/kraken/driver.html?testName=json-stringify-tinderbox) 11:21:27 INFO - 2015-11-23 11:21:27,551 DEBUG : BROWSER_OUTPUT: RSS: Main: 166653952 11:21:27 INFO - 2015-11-23 11:21:27,551 DEBUG : BROWSER_OUTPUT: 11:21:29 INFO - 2015-11-23 11:21:29,341 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45744/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:45744/tests/kraken/driver.html?testName=stanford-crypto-aes) 11:21:29 INFO - 2015-11-23 11:21:29,930 DEBUG : BROWSER_OUTPUT: RSS: Main: 166432768 11:21:29 INFO - 2015-11-23 11:21:29,930 DEBUG : BROWSER_OUTPUT: 11:21:31 INFO - 2015-11-23 11:21:31,974 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45744/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:45744/tests/kraken/driver.html?testName=stanford-crypto-ccm) 11:21:32 INFO - 2015-11-23 11:21:32,555 DEBUG : BROWSER_OUTPUT: RSS: Main: 173252608 11:21:32 INFO - 2015-11-23 11:21:32,555 DEBUG : BROWSER_OUTPUT: 11:21:34 INFO - 2015-11-23 11:21:34,942 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45744/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:45744/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 11:21:35 INFO - 2015-11-23 11:21:35,523 DEBUG : BROWSER_OUTPUT: RSS: Main: 178286592 11:21:35 INFO - 2015-11-23 11:21:35,523 DEBUG : BROWSER_OUTPUT: 11:21:38 INFO - 2015-11-23 11:21:38,084 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45744/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:45744/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 11:21:38 INFO - 2015-11-23 11:21:38,665 DEBUG : BROWSER_OUTPUT: RSS: Main: 177209344 11:21:38 INFO - 2015-11-23 11:21:38,665 DEBUG : BROWSER_OUTPUT: 11:21:40 INFO - 2015-11-23 11:21:40,318 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45744/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:45744/tests/kraken/driver.html?testName=ai-astar) 11:21:40 INFO - 2015-11-23 11:21:40,568 DEBUG : BROWSER_OUTPUT: RSS: Main: 236924928 11:21:40 INFO - 2015-11-23 11:21:40,569 DEBUG : BROWSER_OUTPUT: 11:21:40 INFO - 2015-11-23 11:21:40,570 DEBUG : BROWSER_OUTPUT: __start_tp_report 11:21:40 INFO - 2015-11-23 11:21:40,570 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 11:21:40 INFO - 2015-11-23 11:21:40,570 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 11:21:40 INFO - 2015-11-23 11:21:40,571 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 11:21:40 INFO - 2015-11-23 11:21:40,571 DEBUG : BROWSER_OUTPUT: |0;ai-astar;109;111;106;109;110;111;99;110;112;99 11:21:40 INFO - 2015-11-23 11:21:40,571 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;150;124;156;161;131;161;149;125;174;123 11:21:40 INFO - 2015-11-23 11:21:40,571 DEBUG : BROWSER_OUTPUT: |2;audio-dft;161;161;161;160;162;161;162;163;162;162 11:21:40 INFO - 2015-11-23 11:21:40,571 DEBUG : BROWSER_OUTPUT: |3;audio-fft;73;71;99;96;73;71;75;127;92;71 11:21:40 INFO - 2015-11-23 11:21:40,571 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;92;92;139;92;93;93;136;93;92;138 11:21:40 INFO - 2015-11-23 11:21:40,571 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;109;109;110;109;109;109;110;110;110;109 11:21:40 INFO - 2015-11-23 11:21:40,572 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;145;146;145;146;145;146;145;147;145;146 11:21:40 INFO - 2015-11-23 11:21:40,572 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;96;96;96;96;96;96;96;95;96;97 11:21:40 INFO - 2015-11-23 11:21:40,572 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;61;62;59;60;62;60;61;60;60;58 11:21:40 INFO - 2015-11-23 11:21:40,572 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;68;68;68;68;69;68;73;68;68;69 11:21:40 INFO - 2015-11-23 11:21:40,572 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;82;85;84;91;83;85;84;84;84;84 11:21:40 INFO - 2015-11-23 11:21:40,572 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;128;117;120;121;120;115;123;122;124;115 11:21:40 INFO - 2015-11-23 11:21:40,573 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;144;161;145;152;148;139;142;149;155;144 11:21:40 INFO - 2015-11-23 11:21:40,573 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;67;66;68;68;66;67;67;70;66;67 11:21:40 INFO - 2015-11-23 11:21:40,573 DEBUG : BROWSER_OUTPUT: __end_tp_report 11:21:40 INFO - 2015-11-23 11:21:40,573 DEBUG : BROWSER_OUTPUT: __start_cc_report 11:21:40 INFO - 2015-11-23 11:21:40,574 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,948 11:21:40 INFO - 2015-11-23 11:21:40,575 DEBUG : BROWSER_OUTPUT: __end_cc_report 11:21:40 INFO - 2015-11-23 11:21:40,575 DEBUG : BROWSER_OUTPUT: __startTimestamp1448306500568__endTimestamp 11:21:40 INFO - 2015-11-23 11:21:40,575 DEBUG : BROWSER_OUTPUT: 11:21:40 INFO - 2015-11-23 11:21:40,578 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 11:21:40 INFO - 2015-11-23 11:21:40,578 DEBUG : BROWSER_OUTPUT: Number of tests: 14 11:21:40 INFO - 2015-11-23 11:21:40,578 DEBUG : BROWSER_OUTPUT: 11:21:40 INFO - 2015-11-23 11:21:40,578 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:107.60 Median:111.00 stddev:4.81 (4.3%) stddev-sans-first:5.08 11:21:40 INFO - 2015-11-23 11:21:40,578 DEBUG : BROWSER_OUTPUT: Values: 109.0 111.0 106.0 109.0 110.0 111.0 99.0 110.0 112.0 99.0 11:21:40 INFO - 2015-11-23 11:21:40,578 DEBUG : BROWSER_OUTPUT: 11:21:40 INFO - 2015-11-23 11:21:40,579 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:145.40 Median:153.00 stddev:18.36 (12.0%) stddev-sans-first:19.40 11:21:40 INFO - 2015-11-23 11:21:40,579 DEBUG : BROWSER_OUTPUT: Values: 150.0 124.0 156.0 161.0 131.0 161.0 149.0 125.0 174.0 123.0 11:21:40 INFO - 2015-11-23 11:21:40,579 DEBUG : BROWSER_OUTPUT: 11:21:40 INFO - 2015-11-23 11:21:40,579 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:161.50 Median:162.00 stddev:0.85 (0.5%) stddev-sans-first:0.88 11:21:40 INFO - 2015-11-23 11:21:40,579 DEBUG : BROWSER_OUTPUT: Values: 161.0 161.0 161.0 160.0 162.0 161.0 162.0 163.0 162.0 162.0 11:21:40 INFO - 2015-11-23 11:21:40,579 DEBUG : BROWSER_OUTPUT: 11:21:40 INFO - 2015-11-23 11:21:40,579 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:84.80 Median:74.00 stddev:18.58 (25.1%) stddev-sans-first:19.21 11:21:40 INFO - 2015-11-23 11:21:40,579 DEBUG : BROWSER_OUTPUT: Values: 73.0 71.0 99.0 96.0 73.0 71.0 75.0 127.0 92.0 71.0 11:21:40 INFO - 2015-11-23 11:21:40,579 DEBUG : BROWSER_OUTPUT: 11:21:40 INFO - 2015-11-23 11:21:40,579 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:106.00 Median:92.00 stddev:21.87 (23.8%) stddev-sans-first:22.60 11:21:40 INFO - 2015-11-23 11:21:40,579 DEBUG : BROWSER_OUTPUT: Values: 92.0 92.0 139.0 92.0 93.0 93.0 136.0 93.0 92.0 138.0 11:21:40 INFO - 2015-11-23 11:21:40,579 DEBUG : BROWSER_OUTPUT: 11:21:40 INFO - 2015-11-23 11:21:40,579 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:109.40 Median:109.50 stddev:0.52 (0.5%) stddev-sans-first:0.53 11:21:40 INFO - 2015-11-23 11:21:40,579 DEBUG : BROWSER_OUTPUT: Values: 109.0 109.0 110.0 109.0 109.0 109.0 110.0 110.0 110.0 109.0 11:21:40 INFO - 2015-11-23 11:21:40,579 DEBUG : BROWSER_OUTPUT: 11:21:40 INFO - 2015-11-23 11:21:40,579 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:145.60 Median:146.00 stddev:0.70 (0.5%) stddev-sans-first:0.71 11:21:40 INFO - 2015-11-23 11:21:40,580 DEBUG : BROWSER_OUTPUT: Values: 145.0 146.0 145.0 146.0 145.0 146.0 145.0 147.0 145.0 146.0 11:21:40 INFO - 2015-11-23 11:21:40,580 DEBUG : BROWSER_OUTPUT: 11:21:40 INFO - 2015-11-23 11:21:40,580 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:96.00 Median:96.00 stddev:0.47 (0.5%) stddev-sans-first:0.50 11:21:40 INFO - 2015-11-23 11:21:40,580 DEBUG : BROWSER_OUTPUT: Values: 96.0 96.0 96.0 96.0 96.0 96.0 96.0 95.0 96.0 97.0 11:21:40 INFO - 2015-11-23 11:21:40,580 DEBUG : BROWSER_OUTPUT: 11:21:40 INFO - 2015-11-23 11:21:40,580 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:60.30 Median:60.50 stddev:1.25 (2.1%) stddev-sans-first:1.30 11:21:40 INFO - 2015-11-23 11:21:40,580 DEBUG : BROWSER_OUTPUT: Values: 61.0 62.0 59.0 60.0 62.0 60.0 61.0 60.0 60.0 58.0 11:21:40 INFO - 2015-11-23 11:21:40,580 DEBUG : BROWSER_OUTPUT: 11:21:40 INFO - 2015-11-23 11:21:40,580 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:68.70 Median:68.00 stddev:1.57 (2.3%) stddev-sans-first:1.64 11:21:40 INFO - 2015-11-23 11:21:40,580 DEBUG : BROWSER_OUTPUT: Values: 68.0 68.0 68.0 68.0 69.0 68.0 73.0 68.0 68.0 69.0 11:21:40 INFO - 2015-11-23 11:21:40,580 DEBUG : BROWSER_OUTPUT: 11:21:40 INFO - 2015-11-23 11:21:40,580 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:84.60 Median:84.00 stddev:2.41 (2.9%) stddev-sans-first:2.37 11:21:40 INFO - 2015-11-23 11:21:40,580 DEBUG : BROWSER_OUTPUT: Values: 82.0 85.0 84.0 91.0 83.0 85.0 84.0 84.0 84.0 84.0 11:21:40 INFO - 2015-11-23 11:21:40,580 DEBUG : BROWSER_OUTPUT: 11:21:40 INFO - 2015-11-23 11:21:40,580 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:120.50 Median:121.50 stddev:4.09 (3.4%) stddev-sans-first:3.32 11:21:40 INFO - 2015-11-23 11:21:40,580 DEBUG : BROWSER_OUTPUT: Values: 128.0 117.0 120.0 121.0 120.0 115.0 123.0 122.0 124.0 115.0 11:21:40 INFO - 2015-11-23 11:21:40,581 DEBUG : BROWSER_OUTPUT: 11:21:40 INFO - 2015-11-23 11:21:40,581 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:147.90 Median:148.50 stddev:6.61 (4.4%) stddev-sans-first:6.86 11:21:40 INFO - 2015-11-23 11:21:40,581 DEBUG : BROWSER_OUTPUT: Values: 144.0 161.0 145.0 152.0 148.0 139.0 142.0 149.0 155.0 144.0 11:21:40 INFO - 2015-11-23 11:21:40,581 DEBUG : BROWSER_OUTPUT: 11:21:40 INFO - 2015-11-23 11:21:40,581 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.20 Median:67.00 stddev:1.23 (1.8%) stddev-sans-first:1.30 11:21:40 INFO - 2015-11-23 11:21:40,581 DEBUG : BROWSER_OUTPUT: Values: 67.0 66.0 68.0 68.0 66.0 67.0 67.0 70.0 66.0 67.0 11:21:40 INFO - 2015-11-23 11:21:40,581 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 11:21:40 INFO - 2015-11-23 11:21:40,581 DEBUG : BROWSER_OUTPUT: 11:21:41 INFO - 2015-11-23 11:21:41,465 INFO : Browser exited with error code: 0 11:21:41 INFO - 2015-11-23 11:21:41,517 INFO : Completed test kraken (00:00:58) 11:21:41 INFO - 2015-11-23 11:21:41,517 INFO : Starting test v8_7 11:21:41 INFO - 2015-11-23 11:21:41,517 DEBUG : operating with platform_type : linux_ 11:21:41 INFO - 2015-11-23 11:21:41,517 INFO : Initialising browser for v8_7 test... 11:21:41 INFO - 2015-11-23 11:21:41,523 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpxNnZPV/profile http://localhost:45744/getInfo.html 11:21:45 INFO - 2015-11-23 11:21:45,592 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 11:21:45 INFO - 2015-11-23 11:21:45,592 DEBUG : BROWSER_OUTPUT: colorDepth:24 11:21:45 INFO - 2015-11-23 11:21:45,592 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 11:21:45 INFO - 2015-11-23 11:21:45,592 DEBUG : BROWSER_OUTPUT: __metrics 11:21:45 INFO - 2015-11-23 11:21:45,709 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 11:21:46 INFO - 2015-11-23 11:21:46,992 INFO : Browser initialized. 11:21:46 INFO - 2015-11-23 11:21:46,993 INFO : Running cycle 1/1 for v8_7 test... 11:21:46 INFO - 2015-11-23 11:21:46,993 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpxNnZPV/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 11:21:58 INFO - 2015-11-23 11:21:58,787 DEBUG : BROWSER_OUTPUT: RSS: Main: 139710464 11:21:58 INFO - 2015-11-23 11:21:58,787 DEBUG : BROWSER_OUTPUT: 11:22:20 INFO - 2015-11-23 11:22:20,208 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45744/tests/v8_7/run.html (next: http://localhost:45744/tests/v8_7/run.html) 11:22:20 INFO - 2015-11-23 11:22:20,458 DEBUG : BROWSER_OUTPUT: RSS: Main: 592228352 11:22:20 INFO - 2015-11-23 11:22:20,458 DEBUG : BROWSER_OUTPUT: 11:22:20 INFO - 2015-11-23 11:22:20,458 DEBUG : BROWSER_OUTPUT: __start_tp_report 11:22:20 INFO - 2015-11-23 11:22:20,459 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 11:22:20 INFO - 2015-11-23 11:22:20,459 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 11:22:20 INFO - 2015-11-23 11:22:20,459 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 11:22:20 INFO - 2015-11-23 11:22:20,459 DEBUG : BROWSER_OUTPUT: |0;Richards;189.75332068311195 11:22:20 INFO - 2015-11-23 11:22:20,460 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;188.46588767433096 11:22:20 INFO - 2015-11-23 11:22:20,461 DEBUG : BROWSER_OUTPUT: |2;Encrypt;280.8199943836001 11:22:20 INFO - 2015-11-23 11:22:20,461 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5010 11:22:20 INFO - 2015-11-23 11:22:20,461 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1943.6893203883494 11:22:20 INFO - 2015-11-23 11:22:20,461 DEBUG : BROWSER_OUTPUT: |5;Earley;749.0636704119851 11:22:20 INFO - 2015-11-23 11:22:20,461 DEBUG : BROWSER_OUTPUT: |6;Boyer;12219.512195121952 11:22:20 INFO - 2015-11-23 11:22:20,461 DEBUG : BROWSER_OUTPUT: |7;RegExp;25350 11:22:20 INFO - 2015-11-23 11:22:20,462 DEBUG : BROWSER_OUTPUT: |8;Splay;633.3122229259025 11:22:20 INFO - 2015-11-23 11:22:20,462 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4835.748792270531 11:22:20 INFO - 2015-11-23 11:22:20,462 DEBUG : BROWSER_OUTPUT: __end_tp_report 11:22:20 INFO - 2015-11-23 11:22:20,462 DEBUG : BROWSER_OUTPUT: __startTimestamp1448306540458__endTimestamp 11:22:20 INFO - 2015-11-23 11:22:20,462 DEBUG : BROWSER_OUTPUT: 11:22:20 INFO - 2015-11-23 11:22:20,462 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 11:22:20 INFO - 2015-11-23 11:22:20,463 DEBUG : BROWSER_OUTPUT: Number of tests: 10 11:22:20 INFO - 2015-11-23 11:22:20,463 DEBUG : BROWSER_OUTPUT: 11:22:20 INFO - 2015-11-23 11:22:20,463 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:189.75 Median:189.75 stddev:0.00 (0.0%) 11:22:20 INFO - 2015-11-23 11:22:20,463 DEBUG : BROWSER_OUTPUT: Values: 189.8 11:22:20 INFO - 2015-11-23 11:22:20,463 DEBUG : BROWSER_OUTPUT: 11:22:20 INFO - 2015-11-23 11:22:20,464 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:188.47 Median:188.47 stddev:0.00 (0.0%) 11:22:20 INFO - 2015-11-23 11:22:20,464 DEBUG : BROWSER_OUTPUT: Values: 188.5 11:22:20 INFO - 2015-11-23 11:22:20,464 DEBUG : BROWSER_OUTPUT: 11:22:20 INFO - 2015-11-23 11:22:20,464 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:280.82 Median:280.82 stddev:0.00 (0.0%) 11:22:20 INFO - 2015-11-23 11:22:20,464 DEBUG : BROWSER_OUTPUT: Values: 280.8 11:22:20 INFO - 2015-11-23 11:22:20,464 DEBUG : BROWSER_OUTPUT: 11:22:20 INFO - 2015-11-23 11:22:20,465 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5010.00 Median:5010.00 stddev:0.00 (0.0%) 11:22:20 INFO - 2015-11-23 11:22:20,465 DEBUG : BROWSER_OUTPUT: Values: 5010.0 11:22:20 INFO - 2015-11-23 11:22:20,465 DEBUG : BROWSER_OUTPUT: 11:22:20 INFO - 2015-11-23 11:22:20,465 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1943.69 Median:1943.69 stddev:0.00 (0.0%) 11:22:20 INFO - 2015-11-23 11:22:20,465 DEBUG : BROWSER_OUTPUT: Values: 1943.7 11:22:20 INFO - 2015-11-23 11:22:20,465 DEBUG : BROWSER_OUTPUT: 11:22:20 INFO - 2015-11-23 11:22:20,465 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:749.06 Median:749.06 stddev:0.00 (0.0%) 11:22:20 INFO - 2015-11-23 11:22:20,465 DEBUG : BROWSER_OUTPUT: Values: 749.1 11:22:20 INFO - 2015-11-23 11:22:20,465 DEBUG : BROWSER_OUTPUT: 11:22:20 INFO - 2015-11-23 11:22:20,465 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:12219.51 Median:12219.51 stddev:0.00 (0.0%) 11:22:20 INFO - 2015-11-23 11:22:20,466 DEBUG : BROWSER_OUTPUT: Values: 12219.5 11:22:20 INFO - 2015-11-23 11:22:20,466 DEBUG : BROWSER_OUTPUT: 11:22:20 INFO - 2015-11-23 11:22:20,466 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:25350.00 Median:25350.00 stddev:0.00 (0.0%) 11:22:20 INFO - 2015-11-23 11:22:20,467 DEBUG : BROWSER_OUTPUT: Values: 25350.0 11:22:20 INFO - 2015-11-23 11:22:20,467 DEBUG : BROWSER_OUTPUT: 11:22:20 INFO - 2015-11-23 11:22:20,467 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:633.31 Median:633.31 stddev:0.00 (0.0%) 11:22:20 INFO - 2015-11-23 11:22:20,467 DEBUG : BROWSER_OUTPUT: Values: 633.3 11:22:20 INFO - 2015-11-23 11:22:20,467 DEBUG : BROWSER_OUTPUT: 11:22:20 INFO - 2015-11-23 11:22:20,467 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4835.75 Median:4835.75 stddev:0.00 (0.0%) 11:22:20 INFO - 2015-11-23 11:22:20,467 DEBUG : BROWSER_OUTPUT: Values: 4835.7 11:22:20 INFO - 2015-11-23 11:22:20,467 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 11:22:20 INFO - 2015-11-23 11:22:20,467 DEBUG : BROWSER_OUTPUT: 11:22:21 INFO - 2015-11-23 11:22:21,305 INFO : Browser exited with error code: 0 11:22:21 INFO - 2015-11-23 11:22:21,320 INFO : Completed test v8_7 (00:00:39) 11:22:21 INFO - 2015-11-23 11:22:21,461 INFO : Completed test suite (00:20:12) 11:22:21 INFO - 2015-11-23 11:22:21,461 DEBUG : Working with test: dromaeo_css 11:22:21 INFO - 2015-11-23 11:22:21,461 DEBUG : Generating results file: dromaeo_css 11:22:21 INFO - 2015-11-23 11:22:21,462 DEBUG : Working with test: kraken 11:22:21 INFO - 2015-11-23 11:22:21,463 DEBUG : Generating results file: kraken 11:22:21 INFO - 2015-11-23 11:22:21,463 INFO : javascript benchmark 11:22:21 INFO - 2015-11-23 11:22:21,463 DEBUG : Working with test: v8_7 11:22:21 INFO - 2015-11-23 11:22:21,463 DEBUG : Generating results file: v8_7 11:22:21 INFO - 2015-11-23 11:22:21,463 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 11:22:21 INFO - 2015-11-23 11:22:21,527 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,201,35]] 11:22:21 INFO - 2015-11-23 11:22:21,527 DEBUG : process_Request line: dromaeo_css 6977.77 graph.html#tests=[[72,201,35]] 11:22:21 INFO - 2015-11-23 11:22:21,527 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 11:22:21 INFO - 2015-11-23 11:22:21,561 DEBUG : process_Request line: kraken 1505.50 graph.html#tests=[[232,201,35]] 11:22:21 INFO - 2015-11-23 11:22:21,561 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 11:22:21 INFO - 2015-11-23 11:22:21,602 DEBUG : process_Request line: v8_7 19732.12 graph.html#tests=[[230,201,35]] 11:22:21 INFO - 2015-11-23 11:22:21,603 INFO : javascript benchmark 11:22:21 INFO - 2015-11-23 11:22:21,606 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3131.1545882611695, 3227.080282119596, 3249.707526322632, 3261.9836900815494, 3285.4907489339153, 5215.269862219292, 5321.547668448177, 5359.249705041292, 5400.648957817739, 5419.512243898043, 5337.2527846101575, 5379.246905433232, 5387.19192121181, 5474.42518535553, 5581.386047534768, 4941.308216849644, 4998.900021999558, 5015.598752099823, 5024.899502009957, 5036.143855544567, 5021.297018417425, 5025.14572522672, 5076.619253555979, 5086.847394578169, 5095.6942583444925, 4837.806487740486, 4846.854594362175, 4914.533119353656, 4938.9753051234875, 4944.3572335596145, 4914.877128071791, 4916.680415772963, 4920.138975679241, 4934.506549345037, 4959.231319145502, 4612.86161415158, 4889.3643826302705, 4892.510748925079, 4899.902001959977, 4937.925931111036, 5183.559397451221, 5210.635255532115, 5357.866053348697, 5358.383785864637, 5359.517643412073, 5916.704164791743, 5918.2306300181135, 5920.585559010871, 5922.940770592282, 5923.822285331447, 5817.56368272377, 5922.970385148046, 5962.284525856881, 5967.283925928873, 5970.223870896755, 5416.945830541684, 5461.0, 5574.163875418639, 5585.441455854382, 5619.831405057773, 5962.403759624003, 6018.8194354169445, 6023.367546407651, 6024.548158888101, 6041.969790151109, 5767.567432442584, 5769.942300577024, 5771.711414429262, 5772.740226689809, 5784.045632470596, 5570.220169176318, 5745.712714364265, 5830.679312637761, 5890.410958904161, 5945.346011938684, 5799.739011744482, 5847.0, 5850.531957443394, 5854.2096816930025, 5861.0, 5636.830895073154, 5849.356570777211, 5851.853703657357, 5859.0, 5870.236869206976, 4491.438570178728, 4509.0080182359825, 4542.818287268538, 4550.317452382103, 4591.678582499259, 3939.743916645466, 3947.684185265229, 3974.4435778990965, 3990.20195960809, 4072.6741860651077, 5413.404525502192, 5513.2005859150195, 5520.834374968757, 5522.6134170608475, 5534.335879694382, 5819.94180058194, 5823.301203855564, 5843.357230704619, 5871.324797648325, 5908.468237858613, 5612.298462692163, 5645.322561292671, 5647.774089036392, 5652.0, 5654.46282603152, 4957.3059771632, 5051.62112841531, 5136.357955255593, 5160.716160611128, 5193.974030129825, 5996.67018313997, 6032.276126864805, 6080.0, 6082.787102451482, 6123.38766123393, 5892.0, 5966.105084237399, 5969.791057312973, 5971.522278217819, 5971.701414929149, 5774.0, 5894.646321220741, 6155.1075094112, 6185.165002724574, 6185.195924529782, 5743.195952566561, 5767.509761670305, 5854.619449735754, 5861.35525092248, 5919.171316015675, 5896.233489646319, 5961.7615295387695, 5971.671558064349, 5973.790917317873, 5976.432238937294, 5632.521235694848, 5748.338941021669, 5782.624129431573, 5819.679917604572, 5836.970815145897, 5709.0, 5765.250517432707, 5769.711514424346, 5781.971090144522, 5840.766369345179, 5595.608307418442, 5623.8875222496135, 5624.775008999594, 5627.803026894203, 5628.0, 5567.248421463212, 5665.603407761417, 5715.542756579381, 5742.36833948257, 5744.195812586325, 5641.689707066151, 5714.05718056516, 5716.085426331767, 5730.312362516524, 5766.452187042224], "unit": "ms", "name": "dojo.html", "value": 5403.086986820262}, {"lowerIsBetter": false, "replicates": [555.1866515554711, 603.7222877476361, 603.8369640197147, 605.2192671453824, 612.9111278864565, 31898.521522177187, 32560.511592326133, 32573.348533029326, 32578.511322330185, 32598.185045373877, 33229.169270768245, 33301.33397332052, 41016.79491602545, 41711.0, 41774.7911260444, 8754.606042728092, 8902.554872256362, 8926.152015558511, 8933.0, 8946.194842464178, 7738.148803631596, 8571.22858942695, 8658.956705216497, 8659.220670139686, 8662.826743465126, 7708.3447906927695, 7802.687892484294, 10457.320274182191, 10609.681709548688, 10619.681409557727, 10393.53229104692, 10451.216158788122, 10476.109530689824, 10503.579856805718, 10505.579776808918, 7807.765767026998, 10246.436445995467, 10375.79248415035, 10377.0, 10377.325473844252, 31360.37279254402, 42707.78646106781, 43677.34483982743, 43756.56243437557, 43832.78083609593, 3411.846466908995, 3660.5790334111653, 3799.35410980134, 3916.64750172483, 4134.441850350195, 29328.413431731246, 29773.255668608243, 29792.0, 29897.402051959056, 30432.087037388912, 3711.4989476420606, 3765.6046115157787, 3774.226283611853, 3868.6324799144036, 3940.54683711374, 238101.0, 239015.0, 239067.99999999825, 239245.0, 240260.0, 57474.13788793171, 57681.423185767606, 57786.0, 58073.70963145242, 58149.4185058144, 61297.69351153305, 61493.0, 61527.6923615388, 61593.692031539555, 61613.38386616166, 14257.362387958261, 14317.140971541741, 14353.712925741427, 14365.281735913162, 14372.640683982983, 10771.515281812337, 10824.350538967687, 10834.241603087708, 10838.62064827743, 10841.67474975752, 19258.518537036685, 20327.288544900857, 20330.796692033186, 20375.08312125958, 20389.796102039087, 7685.462017658822, 7949.244821741925, 7953.2842044216295, 7999.240167163215, 8045.0748163960725, 924.2698268367914, 961.4471678784587, 986.413084214891, 1027.3630349183554, 1129.486083831871, 28734.425311493655, 28802.135935921957, 28870.7112928868, 28914.0, 29196.854015729787, 962.4081190068058, 1039.4023436524028, 1042.5829668132808, 1049.5539395756773, 1094.3379255550278, 14249.50126745559, 14292.225227635154, 14689.92655036718, 14888.851111488962, 14937.878652665891, 309887.0, 313822.0, 314066.0, 314093.0, 314319.0, 45028.3245751314, 46002.0, 51055.23417148746, 52041.47958520366, 52270.0, 1327.3164320375015, 1332.4670131947298, 1339.1161833190047, 1363.2093385836192, 1365.911215770952, 25664.743352566235, 27986.580201297405, 28890.711092888803, 29196.416071678872, 29746.0, 49055.509444905096, 49463.0, 49552.752236238586, 49670.50329496659, 49690.254646179616, 267958.0, 269554.0, 270090.84591193835, 270108.0, 270186.0, 30253.243668908453, 30467.496237932035, 30605.23486912845, 30708.692913070583, 30787.846060769552, 41762.0, 42559.3616095765, 42577.57422425736, 42871.0, 43292.35061474017, 36862.44706329461, 37146.0, 37596.436053459765, 38140.23719525649, 38163.42754858735, 35655.82172089123, 36622.450663240605, 37330.6266937338, 37559.62440375561, 37679.24641507209, 35711.64288357187, 36333.0, 36540.0864978367, 36557.817210914836, 36623.26753464969, 31942.041738747874, 33014.33971320512, 33203.0, 33569.66430335665, 33932.0, 25543.87228063922, 26538.469230614894, 26619.866900665373, 26954.09723226692, 27118.457630847668], "unit": "ms", "name": "ext.html", "value": 18486.16396840885}, {"lowerIsBetter": false, "replicates": [353.6233910884909, 360.6411620437665, 361.36399936112434, 363.62546577025654, 364.19331181433125, 14146.64633384166, 14296.928515357435, 16432.753508697366, 16736.748948765762, 17396.565085872877, 15897.52307430779, 16014.43949461769, 16190.595235119099, 16739.91630041851, 16747.497575072735, 5168.069747445458, 5304.681719096867, 5309.097453432925, 5309.469053094698, 5313.760880760375, 3947.0, 4071.9389209161886, 5249.86875328116, 5290.973545132289, 5861.120831875211, 5894.0, 5920.88158236835, 5940.34656187819, 5943.732532036069, 5946.762129514815, 5760.337561180476, 5830.970845145789, 5842.036064049448, 5848.736806843703, 5899.174115623816, 5205.479452054764, 5220.660657057279, 5223.242629818693, 5235.240890070956, 5236.319278493771, 11874.228175168586, 12234.08244381675, 20683.0, 21418.0, 21437.0, 2111.345482900306, 2215.4793623498463, 2230.9888450557805, 2316.525112351964, 2615.6730408698913, 9498.477583732893, 9645.373050751748, 10109.797804043952, 10557.208209384327, 12839.1012629116, 1815.301109073003, 1842.0973722875694, 1868.8037756035556, 1910.9808901910942, 1997.4007797660788, 59974.0, 61306.69346653238, 61585.91761947388, 62383.688081559754, 62867.371326287066, 10273.332233404804, 10341.9482902585, 10404.895951040544, 10452.059314661718, 10505.789884202273, 13634.1137826041, 13637.727245455035, 13644.181349119084, 13659.658508537168, 13699.904007679363, 7603.885941710879, 7614.200508946592, 7634.885476717854, 7690.192529784404, 7740.845183096307, 7661.387089032864, 7667.731629392944, 7671.041119860018, 7700.268474494914, 7705.922940770521, 4412.889677758082, 4463.330500424962, 4485.41689580359, 4497.617702495325, 4515.2324104902245, 1720.8451239388264, 1739.478156553029, 1749.3177660712333, 1765.9028753418686, 1774.4587900690155, 548.8134034428314, 859.2739135430551, 886.9822603547893, 964.3249231012622, 973.9902600974041, 16480.505584832234, 16722.24749886258, 17015.404460843813, 17310.82689173092, 17415.216315265843, 828.1614815110445, 926.4533924984291, 928.9210417114621, 980.9509524523745, 989.248171389749, 9473.242140628734, 9734.880488743886, 9813.656522021694, 9844.409335439897, 9962.452065136487, 365242.0, 374317.0, 438781.0, 478984.0, 479060.0, 39748.0, 58717.11924321139, 76417.0, 82032.0, 84314.57842710747, 1113.154002957758, 1124.0333313350511, 1134.8014097532898, 1143.656902929118, 1148.3741360958297, 11327.773444530898, 15002.249887505362, 15384.84615153834, 15912.840871591136, 16195.38046195371, 32791.34417311688, 34525.0, 34548.654513454545, 34967.82516087403, 35344.64655353517, 44124.33813492736, 44915.32627010663, 45296.547034529234, 46549.767251163525, 47061.76469117632, 9819.558119884765, 9873.259505537257, 10015.69952901414, 10024.899751002396, 10131.08820206185, 15250.694986100438, 17065.573360666083, 17408.953433149403, 17945.371911983017, 18038.909805451414, 13946.721065578835, 14336.49822256216, 14349.426022958965, 14784.11295322284, 14932.328045237773, 14354.425822966965, 14418.13491190532, 14549.563513094625, 14848.554543363716, 14853.851461485247, 13784.655383615489, 13908.37412316428, 14923.477678281208, 15066.397344106552, 15230.162341071347, 9041.367104302635, 9685.951570242385, 9767.902320976984, 9903.0, 9930.453825039693, 10277.075063244343, 10776.0, 13651.180929144282, 14762.926185369004, 15123.092614443169], "unit": "ms", "name": "jquery.html", "value": 8780.584710469457}, {"lowerIsBetter": false, "replicates": [1519.240379810095, 1650.8679305655548, 1680.6638672265549, 1722.2422134260933, 1738.956526086848, 6748.730050797968, 7362.116546014479, 7515.173330933607, 7518.323350898411, 7557.735479258227, 7399.223081576438, 7512.699492020326, 7518.699252029912, 7519.6616152273145, 7520.511166774156, 1965.8820470771727, 2003.6894281386408, 2004.8897310647908, 2271.432141964509, 2274.624686926655, 2241.0923575951765, 2296.9655455168186, 2301.7698230177016, 2302.5855346037706, 2303.1938821412455, 2182.3998400439928, 2198.39544125366, 2243.955120897581, 2245.135622785223, 2248.898799554024, 1948.103872218774, 1980.8316293115101, 1982.345825877457, 2164.166795783635, 2216.8004879560835, 2192.572448372568, 2240.372695645222, 2240.451089483071, 2240.7423146338215, 2241.8991145398495, 7470.58911759853, 7509.324160825552, 7526.8118297042465, 7530.774076777706, 7535.510191837513, 4498.437695288089, 4614.2617181250835, 4615.399998000272, 4618.468876079261, 4621.237495813187, 2958.6301712285963, 2993.82037077776, 3062.1579065756873, 3066.432709948667, 3089.891853785129, 972.2659392158945, 1007.2697739833176, 1011.7622358745689, 1011.9342242754198, 1012.0688966151158, 10233.181345492343, 10258.487075646262, 10264.743381415376, 10266.486675666187, 10270.07569318765, 4056.59434056592, 4124.608162224584, 4149.33610622299, 4165.645920096826, 4178.707490475637, 8820.294376449869, 8830.42602230853, 8847.336449766293, 8848.823023539493, 8882.245009174163, 4574.313852922089, 4585.151746926829, 4585.679002469795, 4588.105319462739, 4588.357629931812, 4151.356539736345, 4155.854545090907, 4170.979145104255, 4171.916561668811, 4176.164767046603, 3625.691816195653, 3629.709623230188, 3633.4004889193516, 3649.50731651229, 3678.411454167374, 1226.5952235762177, 1233.6052463211865, 1235.7034311765112, 1241.76406482768, 1244.7510497900457, 978.9951050244703, 1050.894910508943, 1170.9473073711704, 1213.1447329632588, 1215.5380955236953, 6818.4886133540185, 6846.110005699227, 6903.75836845708, 6920.342567456084, 6924.169099708067, 1122.528538014036, 1123.9325640461598, 1126.5043380912373, 1127.8308253761838, 1144.187626784992, 5326.760295786699, 5491.7254137292975, 5839.824805255849, 5931.851703707442, 5947.286325640951, 8870.64517419296, 8926.419782714103, 9063.0, 9088.636454541876, 9206.769830754285, 8957.955210224038, 9099.590518426554, 9114.58984345706, 9118.088191180828, 9123.771905702279, 6785.830354241183, 6993.545419547713, 7011.228764835966, 7150.892736608955, 7159.069320988238, 7045.189803172496, 7070.04554385172, 7086.185088714864, 7092.787216383516, 7099.787006389816, 7615.276548727862, 7829.6085195741125, 7966.3626909848235, 7986.520808751494, 7990.320822730133, 7866.528008319519, 7961.243681850215, 8219.301359384519, 8223.794405139919, 8228.465149765247, 6779.050932869501, 6801.625910574966, 6889.931100688929, 6891.793246202622, 6905.620190889549, 7315.6342182889575, 7390.9260907390235, 7394.149672787698, 7409.073865766779, 7420.220876807857, 6885.104936358442, 6985.44116470671, 7009.579425234502, 7032.085828842218, 7045.295470452914, 6895.5173137881875, 6909.7581584644295, 6954.408875245458, 7010.719571217298, 7013.438924886099, 6593.3736295051895, 6634.966825165843, 6666.600003999775, 6672.065910772399, 6685.866282674417, 6164.643778368752, 6167.0, 6172.321044684992, 6219.844503887439, 6226.40849119333, 5708.172315014383, 5808.419158084158, 6048.60684055535, 6098.817035488943, 6101.328853826164], "unit": "ms", "name": "mootools.html", "value": 4375.955995113349}, {"lowerIsBetter": false, "replicates": [323.2065279738243, 325.5556165833637, 329.73621103117506, 331.9004298710388, 334.0812764896535, 5877.059670452729, 6004.639721616706, 6024.819255422333, 6030.608010479315, 6118.296395914465, 5849.912251316223, 5942.792002279921, 5963.701814909259, 5968.462838344548, 5978.850528736783, 4599.793009314572, 4605.194091034073, 4605.9769701151445, 4615.584597386234, 4618.907621847561, 4394.450693663292, 4486.618637415823, 4503.279475283955, 4619.16854966106, 4624.237000894848, 4565.543445655425, 4568.5431456854385, 4582.243929751587, 4599.44806623204, 4609.516000819899, 4570.520095389969, 4581.473130589975, 4582.977085114587, 4598.655100867431, 4599.0, 4012.578679238696, 4018.1361007383553, 4019.3970904364287, 4019.738716983416, 4028.3353246714255, 5560.443955604448, 5677.460641239076, 5686.2039314496005, 5695.686737229451, 5699.857503562403, 5300.814471493479, 5302.231176479428, 5304.17785243284, 5307.708076055816, 5308.0, 6139.201903752528, 6359.077933699587, 6366.586171898812, 6368.777092801776, 6371.52213583983, 4282.272013757669, 4296.0, 4354.673399495051, 4360.324149756792, 4374.650027997753, 6552.148220731275, 6562.310957349505, 6575.243846957614, 6603.867922641521, 6634.701438435282, 4449.888752781141, 4450.488193857748, 4453.109378124388, 4453.4433195850515, 4457.086297309044, 4419.18245124653, 4509.0, 4509.391232183679, 4514.571115743999, 4531.025829446685, 5248.685078895279, 5258.7370631468275, 5262.473752624784, 5264.236685680631, 5266.078436273637, 6403.935960640427, 6411.326810684905, 6416.326285740023, 6419.903701444482, 6421.2615549211505, 1572.080333005182, 1579.336678594993, 1580.3678528588428, 1580.8182059063124, 1580.8814338924626, 1031.3141760729181, 1056.9048785609332, 1057.360297020307, 1057.5293994172519, 1062.054771253585, 6180.351063138396, 6181.350958149419, 6184.938150618526, 6188.907166392508, 6192.783252586138, 6529.2817790043055, 6542.574732642363, 6585.5719378240265, 6588.8352791180605, 6607.603543787388, 6045.546584006217, 6157.876842463125, 6180.598261113013, 6186.845328866814, 6190.473809726133, 3560.537130173061, 3576.7853928764357, 3576.8554062699686, 3578.4632305154437, 3579.1231148368815, 6798.898016529756, 6819.931800681929, 6821.3519715626935, 6830.59016459014, 6835.248122706498, 6583.144191255106, 6719.092922455504, 6722.058911752359, 6727.529072964846, 6742.292059333699, 6801.897971530431, 6803.319668033157, 6805.829854253584, 6806.829829254309, 6810.421114205348, 6389.744410223539, 6540.869182616226, 6575.80272591823, 6581.243157036811, 6585.111010013587, 6434.485241180788, 6547.836304092436, 6582.80251592453, 6583.374579414948, 6599.8020059398295, 6832.111825462658, 6843.315668433117, 6850.177978642595, 6863.0, 6870.519063665495, 4400.823967041282, 4493.258612328929, 4493.77531123436, 4496.39298694672, 4496.685232033727, 6571.769988050395, 6579.078928950046, 6602.6698665067515, 6607.9669601651685, 6624.370684784938, 6421.775237866652, 6423.197100362455, 6424.646644434601, 6431.903521447276, 6441.711657668391, 6300.779472718433, 6375.107484952203, 6417.518686098468, 6454.741810327534, 6458.7093580789915, 6297.370262973666, 6302.275238347649, 6309.305976342507, 6318.08387783778, 6321.0, 6473.935260647521, 6474.093626892145, 6479.676016199077, 6480.6435646038035, 6487.3836985486305, 6188.0, 6315.242170939517, 6322.589031712924, 6328.873422531431, 6344.429001389897], "unit": "ms", "name": "prototype.html", "value": 4795.072090552482}, {"lowerIsBetter": false, "replicates": [777.1606664802015, 838.513662075996, 851.897772267328, 853.7097386888456, 859.6088779605278, 13029.0, 13508.662283442918, 13526.188428694286, 13541.729165416698, 13549.254790986504, 10765.569377224921, 13200.603981880535, 13237.669058273525, 13253.204807711543, 13306.0, 658.4041442494538, 787.1577412168981, 810.3436216664492, 815.233680340481, 816.0330008939426, 799.8120441696196, 804.5936801915054, 813.0812182234067, 814.1329484099415, 815.7838172884191, 689.7068745783047, 696.053367420308, 831.1729828820332, 834.2325060943916, 834.8747687846841, 826.6775957376628, 841.247083859948, 845.18439705684, 848.1094850407048, 849.762066621347, 614.5605891787349, 618.9907151392732, 623.9438450539474, 623.9469645080128, 624.3849807939176, 13034.739305213938, 13292.335383230897, 13294.800577991338, 13321.40053697586, 13325.933370333183, 11864.644060678194, 12542.24746515203, 12697.555585554554, 13060.673483162902, 13150.408231629504, 10300.442046901911, 10395.94802025985, 10477.161827053817, 10572.52423640938, 10793.136549076055, 3636.3999940009867, 3650.3611867923273, 3655.0, 3733.775973441575, 3830.2722482728473, 44590.10819783618, 44879.55120448819, 45021.549784502065, 45586.08827823425, 45916.08167836658, 10138.594456221816, 10194.01216762739, 10320.793584128276, 10433.791324173473, 10481.109105726098, 18513.7222941656, 18568.535786605444, 18580.349687760863, 18583.16375763094, 18637.068146592617, 7437.405007599487, 7495.925040749523, 7677.0403699537555, 7744.070711514654, 7804.024496937883, 4405.273129933589, 4407.471103467605, 4438.223310920576, 4507.616852567503, 4516.209663308973, 3027.04648035868, 3052.786304958676, 3054.679258677851, 3071.600691910082, 3076.1079287006964, 545.8276061276064, 548.3858078951599, 553.3967974907371, 556.4046470276764, 565.6436445039599, 594.8393933637893, 624.8625302433458, 627.3820287017285, 644.6003477843767, 644.6132320607692, 7512.0, 7567.167611562723, 7657.234276572298, 7880.330171935335, 7920.564368959763, 534.3000669123461, 642.877853207889, 649.5900210220136, 651.1437459740521, 652.9347065293433, 3693.0, 3814.136371964983, 3954.7231693781737, 3970.404439334065, 4105.158442519277, 54813.451865481635, 56426.0, 57583.424165758646, 57640.71179644159, 57751.0, 50220.0, 50802.23796643053, 51921.0, 51940.74029629903, 52248.477515225124, 45558.0, 45884.082318353445, 46715.5328446718, 46722.065558688635, 47387.76306118447, 8325.209105135002, 8460.53467059293, 8560.700375486827, 8569.0, 8725.0, 35171.0, 35634.64365356313, 36169.81915090408, 37034.44448333331, 37145.07137321481, 44631.776841115585, 44664.55335446604, 44919.0, 45320.093598128515, 45841.54158458373, 11361.37512436824, 11416.771664566828, 11493.310401375944, 11517.82723259135, 11704.824427633423, 12379.69050773738, 12495.312757798409, 12594.685132871751, 12609.747805044031, 12666.43001064936, 10492.265541412333, 10768.784624307627, 10775.030247277782, 10947.616833410792, 11300.94349528247, 11636.825447618461, 11929.105317101426, 11981.341026243641, 12250.142490025613, 12396.504139834306, 10916.50875710579, 10924.672259832218, 10940.671779846618, 11271.211015229183, 11327.546898123983, 9853.612309533846, 10130.341527800669, 10173.643922462974, 10251.692449226535, 10842.620508282173, 8426.241638252586, 8534.957325213334, 8559.186877246651, 8806.295496360404, 9689.370190937567], "unit": "ms", "name": "yui.html", "value": 6271.63404041406}], "name": "dromaeo_css", "value": 6977.770106258737}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [109.0, 111.0, 106.0, 109.0, 110.0, 111.0, 99.0, 110.0, 112.0, 99.0], "unit": "ms", "name": "ai-astar", "value": 107.6}, {"lowerIsBetter": true, "replicates": [150.0, 124.0, 156.0, 161.0, 131.0, 161.0, 149.0, 125.0, 174.0, 123.0], "unit": "ms", "name": "audio-beat-detection", "value": 145.4}, {"lowerIsBetter": true, "replicates": [161.0, 161.0, 161.0, 160.0, 162.0, 161.0, 162.0, 163.0, 162.0, 162.0], "unit": "ms", "name": "audio-dft", "value": 161.5}, {"lowerIsBetter": true, "replicates": [73.0, 71.0, 99.0, 96.0, 73.0, 71.0, 75.0, 127.0, 92.0, 71.0], "unit": "ms", "name": "audio-fft", "value": 84.8}, {"lowerIsBetter": true, "replicates": [92.0, 92.0, 139.0, 92.0, 93.0, 93.0, 136.0, 93.0, 92.0, 138.0], "unit": "ms", "name": "audio-oscillator", "value": 106.0}, {"lowerIsBetter": true, "replicates": [109.0, 109.0, 110.0, 109.0, 109.0, 109.0, 110.0, 110.0, 110.0, 109.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 109.4}, {"lowerIsBetter": true, "replicates": [145.0, 146.0, 145.0, 146.0, 145.0, 146.0, 145.0, 147.0, 145.0, 146.0], "unit": "ms", "name": "imaging-darkroom", "value": 145.6}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 96.0, 96.0, 96.0, 96.0, 96.0, 95.0, 96.0, 97.0], "unit": "ms", "name": "imaging-desaturate", "value": 96.0}, {"lowerIsBetter": true, "replicates": [61.0, 62.0, 59.0, 60.0, 62.0, 60.0, 61.0, 60.0, 60.0, 58.0], "unit": "ms", "name": "json-parse-financial", "value": 60.3}, {"lowerIsBetter": true, "replicates": [68.0, 68.0, 68.0, 68.0, 69.0, 68.0, 73.0, 68.0, 68.0, 69.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 68.7}, {"lowerIsBetter": true, "replicates": [82.0, 85.0, 84.0, 91.0, 83.0, 85.0, 84.0, 84.0, 84.0, 84.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 84.6}, {"lowerIsBetter": true, "replicates": [128.0, 117.0, 120.0, 121.0, 120.0, 115.0, 123.0, 122.0, 124.0, 115.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 120.5}, {"lowerIsBetter": true, "replicates": [144.0, 161.0, 145.0, 152.0, 148.0, 139.0, 142.0, 149.0, 155.0, 144.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 147.9}, {"lowerIsBetter": true, "replicates": [67.0, 66.0, 68.0, 68.0, 66.0, 67.0, 67.0, 70.0, 66.0, 67.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 67.2}], "name": "kraken", "value": 1505.5}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [189.75332068311195], "unit": "score", "name": "Richards", "value": 186.04154000000005}, {"lowerIsBetter": false, "replicates": [188.46588767433096], "unit": "score", "name": "DeltaBlue", "value": 350.8221079999999}, {"lowerIsBetter": false, "replicates": [280.8199943836001], "unit": "score", "name": "Encrypt", "value": 947.8705409999999}, {"lowerIsBetter": false, "replicates": [5010.0], "unit": "score", "name": "Decrypt", "value": 53.12994011976049}, {"lowerIsBetter": false, "replicates": [1943.6893203883494], "unit": "score", "name": "RayTrace", "value": 380.7136213786215}, {"lowerIsBetter": false, "replicates": [749.0636704119851], "unit": "score", "name": "Earley", "value": 889.7281049999999}, {"lowerIsBetter": false, "replicates": [12219.512195121952], "unit": "score", "name": "Boyer", "value": 54.540884231536886}, {"lowerIsBetter": false, "replicates": [25350.0], "unit": "score", "name": "RegExp", "value": 35.936291913214966}, {"lowerIsBetter": false, "replicates": [633.3122229259025], "unit": "score", "name": "Splay", "value": 128.674289}, {"lowerIsBetter": false, "replicates": [4835.748792270531], "unit": "score", "name": "NavierStokes", "value": 306.881118881119}], "name": "v8_7", "value": 19732.12054381009}]} 11:22:21 INFO - RETURN: dromaeo_css: 6977.77 11:22:21 INFO - RETURN: kraken: 1505.50 11:22:21 INFO - RETURN: v8_7: 19732.12 11:22:21 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,201,35]]", "result": "19732.12"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,201,35]]", "result": "1505.50"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,201,35]]", "result": "6977.77"}}} 11:22:21 INFO - Return code: 0 11:22:21 INFO - # TBPL SUCCESS # 11:22:21 INFO - Running post-action listener: _resource_record_post_action 11:22:21 INFO - Running post-run listener: _resource_record_post_run 11:22:22 INFO - Total resource usage - Wall time: 1227s; CPU: 13.0%; Read bytes: 4096; Write bytes: 506998784; Read time: 20; Write time: 548256 11:22:22 INFO - install - Wall time: 15s; CPU: 15.0%; Read bytes: 0; Write bytes: 238022656; Read time: 0; Write time: 389920 11:22:22 INFO - run-tests - Wall time: 1213s; CPU: 13.0%; Read bytes: 4096; Write bytes: 268963840; Read time: 20; Write time: 158336 11:22:22 INFO - Running post-run listener: _upload_blobber_files 11:22:22 INFO - Blob upload gear active. 11:22:22 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 11:22:22 INFO - Copying logs to upload dir... 11:22:22 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1257.103896 ========= master_lag: 0.14 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 57 secs) (at 2015-11-23 11:22:22.425080) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-23 11:22:22.428584) ========= 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=70a720fcaf18edea6683c2dc000001ad-1448302623.128361-1466739435 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/ympYqEcbRjyjKqcI_KLc1A/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.009791 build_url: 'https://queue.taskcluster.net/v1/task/ympYqEcbRjyjKqcI_KLc1A/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2' ========= master_lag: 0.04 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-23 11:22:22.480385) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 11:22:22.480757) ========= 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=70a720fcaf18edea6683c2dc000001ad-1448302623.128361-1466739435 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004642 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 11:22:22.531276) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-23 11:22:22.531637) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-23 11:22:22.531972) ========= ========= Total master_lag: 0.37 =========