builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-023 starttime: 1448440664.88 results: success (0) buildid: 20151124223107 builduid: 601d9a2c60f34d5f9637010a03b244d3 revision: 8021382da9722db0ad97ebd93698b69a74f0d9b0 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-11-25 00:37:44.881497) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-11-25 00:37:44.881944) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-25 00:37:44.882239) ========= 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=e10134013339c31d8d0c4708000001d6-1448440368.874188-1470675506 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006636 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.01 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-25 00:37:44.903644) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-25 00:37:44.903942) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-25 00:37:44.916918) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-25 00:37:44.917311) ========= 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=e10134013339c31d8d0c4708000001d6-1448440368.874188-1470675506 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004667 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-25 00:37:44.966673) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-25 00:37:44.966964) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-25 00:37:44.967366) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-25 00:37:44.967634) ========= 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=e10134013339c31d8d0c4708000001d6-1448440368.874188-1470675506 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-11-25 00:37:45-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 43.9M=0s 2015-11-25 00:37:45 (43.9 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.165758 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-25 00:37:45.145492) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-25 00:37:45.145874) ========= 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=e10134013339c31d8d0c4708000001d6-1448440368.874188-1470675506 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.022455 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-25 00:37:45.197223) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-25 00:37:45.197565) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 8021382da9722db0ad97ebd93698b69a74f0d9b0 --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/mozilla-inbound --rev 8021382da9722db0ad97ebd93698b69a74f0d9b0 --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=e10134013339c31d8d0c4708000001d6-1448440368.874188-1470675506 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-11-25 00:37:45,894 truncating revision to first 12 chars 2015-11-25 00:37:45,894 Setting DEBUG logging. 2015-11-25 00:37:45,894 attempt 1/10 2015-11-25 00:37:45,894 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/8021382da972?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-11-25 00:37:46,528 unpacking tar archive at: mozilla-inbound-8021382da972/testing/mozharness/ program finished with exit code 0 elapsedTime=0.922611 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-25 00:37:46.134578) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-25 00:37:46.134879) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-25 00:37:46.146447) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-25 00:37:46.146697) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-25 00:37:46.147159) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 9 secs) (at 2015-11-25 00:37:46.147438) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Inbound --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-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', 'Mozilla-Inbound', '--system-bits', '64', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-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=e10134013339c31d8d0c4708000001d6-1448440368.874188-1470675506 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 00:37:46 INFO - MultiFileLogger online at 20151125 00:37:46 in /builds/slave/test-pgo 00:37:46 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Inbound --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound 00:37:46 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 00:37:46 INFO - {'append_to_log': False, 00:37:46 INFO - 'base_work_dir': '/builds/slave/test-pgo', 00:37:46 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 00:37:46 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 00:37:46 INFO - 'branch': 'Mozilla-Inbound', 00:37:46 INFO - 'buildbot_json_path': 'buildprops.json', 00:37:46 INFO - 'config_files': ('talos/linux_config.py',), 00:37:46 INFO - 'default_actions': ('clobber', 00:37:46 INFO - 'read-buildbot-config', 00:37:46 INFO - 'download-and-extract', 00:37:46 INFO - 'populate-webroot', 00:37:46 INFO - 'create-virtualenv', 00:37:46 INFO - 'install', 00:37:46 INFO - 'run-tests'), 00:37:46 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 00:37:46 INFO - 'download_minidump_stackwalk': True, 00:37:46 INFO - 'download_symbols': 'ondemand', 00:37:46 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 00:37:46 INFO - 'tooltool.py': '/tools/tooltool.py', 00:37:46 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 00:37:46 INFO - '/tools/misc-python/virtualenv.py')}, 00:37:46 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 00:37:46 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 00:37:46 INFO - 'installer_path': 'installer.exe', 00:37:46 INFO - 'log_level': 'info', 00:37:46 INFO - 'log_name': 'talos', 00:37:46 INFO - 'log_to_console': True, 00:37:46 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 00:37:46 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 00:37:46 INFO - 'opt_config_files': (), 00:37:46 INFO - 'pip_index': False, 00:37:46 INFO - 'sps_profile': False, 00:37:46 INFO - 'sps_profile_interval': 0, 00:37:46 INFO - 'suite': 'dromaeojs', 00:37:46 INFO - 'system_bits': '64', 00:37:46 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 00:37:46 INFO - 'title': 'talos-linux64-ix-023', 00:37:46 INFO - 'tooltool_cache': '/builds/tooltool_cache', 00:37:46 INFO - 'use_talos_json': True, 00:37:46 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 00:37:46 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 00:37:46 INFO - 'work_dir': 'build'} 00:37:46 INFO - ##### 00:37:46 INFO - ##### Running clobber step. 00:37:46 INFO - ##### 00:37:46 INFO - Running pre-action listener: _resource_record_pre_action 00:37:46 INFO - Running main action method: clobber 00:37:46 INFO - rmtree: /builds/slave/test-pgo/build 00:37:46 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 00:37:47 INFO - Running post-action listener: _resource_record_post_action 00:37:47 INFO - ##### 00:37:47 INFO - ##### Running read-buildbot-config step. 00:37:47 INFO - ##### 00:37:47 INFO - Running pre-action listener: _resource_record_pre_action 00:37:47 INFO - Running main action method: read_buildbot_config 00:37:47 INFO - Using buildbot properties: 00:37:47 INFO - { 00:37:47 INFO - "properties": { 00:37:47 INFO - "buildnumber": 1298, 00:37:47 INFO - "product": "firefox", 00:37:47 INFO - "script_repo_revision": "production", 00:37:47 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs", 00:37:47 INFO - "repository": "", 00:37:47 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound pgo talos dromaeojs", 00:37:47 INFO - "buildid": "20151124223107", 00:37:47 INFO - "slavename": "talos-linux64-ix-023", 00:37:47 INFO - "pgo_build": "True", 00:37:47 INFO - "basedir": "/builds/slave/test-pgo", 00:37:47 INFO - "project": "", 00:37:47 INFO - "platform": "ubuntu64_hw", 00:37:47 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 00:37:47 INFO - "slavebuilddir": "test", 00:37:47 INFO - "scheduler": "tests-mozilla-inbound-linux64-pgo-talos", 00:37:47 INFO - "branch": "mozilla-inbound", 00:37:47 INFO - "repo_path": "integration/mozilla-inbound", 00:37:47 INFO - "stage_platform": "linux64-pgo", 00:37:47 INFO - "builduid": "601d9a2c60f34d5f9637010a03b244d3", 00:37:47 INFO - "revision": "8021382da9722db0ad97ebd93698b69a74f0d9b0" 00:37:47 INFO - }, 00:37:47 INFO - "sourcestamp": { 00:37:47 INFO - "repository": "", 00:37:47 INFO - "hasPatch": false, 00:37:47 INFO - "project": "", 00:37:47 INFO - "branch": "mozilla-inbound-linux64-pgo-talos", 00:37:47 INFO - "changes": [ 00:37:47 INFO - { 00:37:47 INFO - "category": null, 00:37:47 INFO - "files": [ 00:37:47 INFO - { 00:37:47 INFO - "url": null, 00:37:47 INFO - "name": "https://queue.taskcluster.net/v1/task/px5GceqESrG3iOAqINa-1w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2" 00:37:47 INFO - } 00:37:47 INFO - ], 00:37:47 INFO - "repository": "", 00:37:47 INFO - "rev": "8021382da9722db0ad97ebd93698b69a74f0d9b0", 00:37:47 INFO - "who": "sendchange", 00:37:47 INFO - "when": 1448440591, 00:37:47 INFO - "number": 6704527, 00:37:47 INFO - "comments": "", 00:37:47 INFO - "project": "", 00:37:47 INFO - "at": "Wed 25 Nov 2015 00:36:31", 00:37:47 INFO - "branch": "mozilla-inbound-linux64-pgo-talos", 00:37:47 INFO - "revlink": "", 00:37:47 INFO - "properties": [ 00:37:47 INFO - [ 00:37:47 INFO - "buildid", 00:37:47 INFO - "20151124223107", 00:37:47 INFO - "Change" 00:37:47 INFO - ], 00:37:47 INFO - [ 00:37:47 INFO - "builduid", 00:37:47 INFO - "601d9a2c60f34d5f9637010a03b244d3", 00:37:47 INFO - "Change" 00:37:47 INFO - ], 00:37:47 INFO - [ 00:37:47 INFO - "pgo_build", 00:37:47 INFO - "True", 00:37:47 INFO - "Change" 00:37:47 INFO - ] 00:37:47 INFO - ], 00:37:47 INFO - "revision": "8021382da9722db0ad97ebd93698b69a74f0d9b0" 00:37:47 INFO - } 00:37:47 INFO - ], 00:37:47 INFO - "revision": "8021382da9722db0ad97ebd93698b69a74f0d9b0" 00:37:47 INFO - } 00:37:47 INFO - } 00:37:47 INFO - Found installer url https://queue.taskcluster.net/v1/task/px5GceqESrG3iOAqINa-1w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2. 00:37:47 INFO - Running post-action listener: _resource_record_post_action 00:37:47 INFO - ##### 00:37:47 INFO - ##### Running download-and-extract step. 00:37:47 INFO - ##### 00:37:47 INFO - Running pre-action listener: _resource_record_pre_action 00:37:47 INFO - Running main action method: download_and_extract 00:37:47 INFO - mkdir: /builds/slave/test-pgo/build/tests 00:37:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:37:47 INFO - https://queue.taskcluster.net/v1/task/px5GceqESrG3iOAqINa-1w/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 00:37:47 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/px5GceqESrG3iOAqINa-1w/artifacts/public/build/test_packages.json 00:37:47 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/px5GceqESrG3iOAqINa-1w/artifacts/public/build/test_packages.json 00:37:47 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/px5GceqESrG3iOAqINa-1w/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 00:37:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/px5GceqESrG3iOAqINa-1w/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 00:37:52 INFO - Downloaded 1302 bytes. 00:37:52 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 00:37:52 INFO - Using the following test package requirements: 00:37:52 INFO - {u'common': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 00:37:52 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 00:37:52 INFO - u'firefox-45.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 00:37:52 INFO - u'jittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 00:37:52 INFO - u'jsshell-linux-x86_64.zip'], 00:37:52 INFO - u'mochitest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 00:37:52 INFO - u'firefox-45.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 00:37:52 INFO - u'mozbase': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 00:37:52 INFO - u'reftest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 00:37:52 INFO - u'firefox-45.0a1.en-US.linux-x86_64.reftest.tests.zip'], 00:37:52 INFO - u'talos': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 00:37:52 INFO - u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'], 00:37:52 INFO - u'web-platform': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 00:37:52 INFO - u'firefox-45.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 00:37:52 INFO - u'webapprt': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 00:37:52 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 00:37:52 INFO - u'firefox-45.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 00:37:52 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 00:37:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:37:52 INFO - https://queue.taskcluster.net/v1/task/px5GceqESrG3iOAqINa-1w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 00:37:52 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/px5GceqESrG3iOAqINa-1w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 00:37:52 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/px5GceqESrG3iOAqINa-1w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 00:37:52 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/px5GceqESrG3iOAqINa-1w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 00:37:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/px5GceqESrG3iOAqINa-1w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 00:38:01 INFO - Downloaded 22754037 bytes. 00:38:01 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test-pgo/build/tests 00:38:01 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 00:38:01 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 00:38:02 INFO - Return code: 0 00:38:02 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 00:38:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:38:02 INFO - https://queue.taskcluster.net/v1/task/px5GceqESrG3iOAqINa-1w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 00:38:02 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/px5GceqESrG3iOAqINa-1w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 00:38:02 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/px5GceqESrG3iOAqINa-1w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 00:38:02 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/px5GceqESrG3iOAqINa-1w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 00:38:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/px5GceqESrG3iOAqINa-1w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 00:38:03 INFO - Downloaded 22754037 bytes. 00:38:03 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test-pgo/build/tests 00:38:03 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 00:38:03 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 00:38:05 INFO - Return code: 0 00:38:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:38:05 INFO - https://queue.taskcluster.net/v1/task/px5GceqESrG3iOAqINa-1w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 00:38:05 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/px5GceqESrG3iOAqINa-1w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 00:38:05 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/px5GceqESrG3iOAqINa-1w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 00:38:05 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/px5GceqESrG3iOAqINa-1w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 00:38:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/px5GceqESrG3iOAqINa-1w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 00:38:06 INFO - Downloaded 11131717 bytes. 00:38:06 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'] in /builds/slave/test-pgo/build/tests 00:38:06 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 00:38:06 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'] with output_timeout 1760 00:38:06 INFO - Return code: 0 00:38:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:38:06 INFO - https://queue.taskcluster.net/v1/task/px5GceqESrG3iOAqINa-1w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 00:38:06 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/px5GceqESrG3iOAqINa-1w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 00:38:06 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/px5GceqESrG3iOAqINa-1w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 00:38:06 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/px5GceqESrG3iOAqINa-1w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 00:38:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/px5GceqESrG3iOAqINa-1w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 00:38:07 INFO - Downloaded 58383879 bytes. 00:38:07 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/px5GceqESrG3iOAqINa-1w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 00:38:07 INFO - mkdir: /builds/slave/test-pgo/properties 00:38:07 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 00:38:07 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 00:38:07 INFO - Contents: 00:38:07 INFO - build_url:https://queue.taskcluster.net/v1/task/px5GceqESrG3iOAqINa-1w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 00:38:07 INFO - Running post-action listener: _resource_record_post_action 00:38:07 INFO - Running post-action listener: set_extra_try_arguments 00:38:07 INFO - ##### 00:38:07 INFO - ##### Running populate-webroot step. 00:38:07 INFO - ##### 00:38:07 INFO - Running pre-action listener: _resource_record_pre_action 00:38:07 INFO - Running main action method: populate_webroot 00:38:07 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 00:38:07 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 00:38:07 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 00:38:07 INFO - '../fennec_ids.txt'], 00:38:07 INFO - 'tests': ['tcheck2']}, 00:38:07 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 00:38:07 INFO - '--tppagecycles', 00:38:07 INFO - '7'], 00:38:07 INFO - 'tests': ['tsvgm']}}, 00:38:07 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 00:38:07 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 00:38:07 INFO - 'tests': ['tresize', 'tcanvasmark']}, 00:38:07 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 00:38:07 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 00:38:07 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 00:38:07 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:38:07 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 00:38:07 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:38:07 INFO - 'talos_options': ['--e10s'], 00:38:07 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 00:38:07 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:38:07 INFO - 'tests': ['damp', 'tps']}, 00:38:07 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:38:07 INFO - 'talos_options': ['--e10s'], 00:38:07 INFO - 'tests': ['damp', 'tps']}, 00:38:07 INFO - 'g3': {'tests': ['dromaeo_dom']}, 00:38:07 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 00:38:07 INFO - 'other': {'tests': ['a11yr', 00:38:07 INFO - 'ts_paint', 00:38:07 INFO - 'tpaint', 00:38:07 INFO - 'sessionrestore', 00:38:07 INFO - 'sessionrestore_no_auto_restore']}, 00:38:07 INFO - 'other-e10s': {'talos_options': ['--e10s'], 00:38:07 INFO - 'tests': ['a11yr', 00:38:07 INFO - 'ts_paint', 00:38:07 INFO - 'tpaint', 00:38:07 INFO - 'sessionrestore', 00:38:07 INFO - 'sessionrestore_no_auto_restore']}, 00:38:07 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 00:38:07 INFO - 'tests': ['a11yr', 00:38:07 INFO - 'ts_paint', 00:38:07 INFO - 'tpaint', 00:38:07 INFO - 'sessionrestore', 00:38:07 INFO - 'sessionrestore_no_auto_restore']}, 00:38:07 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 00:38:07 INFO - 'tests': ['a11yr', 00:38:07 INFO - 'ts_paint', 00:38:07 INFO - 'tpaint', 00:38:07 INFO - 'sessionrestore', 00:38:07 INFO - 'sessionrestore_no_auto_restore']}, 00:38:07 INFO - 'other_l64': {'tests': ['a11yr', 00:38:07 INFO - 'ts_paint', 00:38:07 INFO - 'tpaint', 00:38:07 INFO - 'sessionrestore', 00:38:07 INFO - 'sessionrestore_no_auto_restore']}, 00:38:07 INFO - 'other_nol64': {'tests': ['a11yr', 00:38:07 INFO - 'ts_paint', 00:38:07 INFO - 'tpaint', 00:38:07 INFO - 'sessionrestore', 00:38:07 INFO - 'sessionrestore_no_auto_restore']}, 00:38:07 INFO - 'svgr': {'tests': ['tsvgx', 00:38:07 INFO - 'tsvgr_opacity', 00:38:07 INFO - 'tart', 00:38:07 INFO - 'tscrollx', 00:38:07 INFO - 'cart']}, 00:38:07 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 00:38:07 INFO - 'tests': ['tsvgx', 00:38:07 INFO - 'tsvgr_opacity', 00:38:07 INFO - 'tart', 00:38:07 INFO - 'tscrollx', 00:38:07 INFO - 'cart']}, 00:38:07 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:38:07 INFO - 'tests': ['tp5o']}, 00:38:07 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:38:07 INFO - 'talos_options': ['--e10s'], 00:38:07 INFO - 'tests': ['tp5o']}, 00:38:07 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:38:07 INFO - 'talos_options': ['--xperf_path', 00:38:07 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 00:38:07 INFO - 'tests': ['tp5n']}, 00:38:07 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:38:07 INFO - 'talos_options': ['--e10s', 00:38:07 INFO - '--xperf_path', 00:38:07 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 00:38:07 INFO - 'tests': ['tp5n']}}, 00:38:07 INFO - 'talos.zip': {'path': '', 00:38:07 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 00:38:07 INFO - Running post-action listener: _resource_record_post_action 00:38:07 INFO - ##### 00:38:07 INFO - ##### Running create-virtualenv step. 00:38:07 INFO - ##### 00:38:07 INFO - Running pre-action listener: _resource_record_pre_action 00:38:07 INFO - Running main action method: create_virtualenv 00:38:07 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 00:38:07 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test-pgo/build/venv'] in /builds/slave/test-pgo/build 00:38:07 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 00:38:07 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 00:38:07 INFO - Using real prefix '/usr' 00:38:07 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 00:38:08 INFO - Installing distribute.............................................................................................................................................................................................done. 00:38:10 INFO - Installing pip.................done. 00:38:10 INFO - Return code: 0 00:38:10 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 00:38:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:38:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:38:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:38:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:38:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:38:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:38:10 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 0x22e3030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24448a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2510c70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x259fe50>, '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 0x25a0d50>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25a11e0>, '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': 'e10134013339c31d8d0c4708000001d6-1448440368.874188-1470675506', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 00:38:10 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test-pgo/build 00:38:10 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 00:38:10 INFO - Using env: {'DISPLAY': ':0', 00:38:10 INFO - 'HOME': '/home/cltbld', 00:38:10 INFO - 'LANG': 'en_US.UTF-8', 00:38:10 INFO - 'LANGUAGE': 'en_US:en', 00:38:10 INFO - 'LOGNAME': 'cltbld', 00:38:10 INFO - 'MAIL': '/var/mail/cltbld', 00:38:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:38:10 INFO - 'MOZ_NO_REMOTE': '1', 00:38:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:38:10 INFO - 'NO_EM_RESTART': '1', 00:38:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:38:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 00:38:10 INFO - 'PWD': '/builds/slave/test-pgo', 00:38:10 INFO - 'SHELL': '/bin/bash', 00:38:10 INFO - 'SHLVL': '1', 00:38:10 INFO - 'TERM': 'linux', 00:38:10 INFO - 'TMOUT': '86400', 00:38:10 INFO - 'USER': 'cltbld', 00:38:10 INFO - 'XDG_SESSION_COOKIE': 'e10134013339c31d8d0c4708000001d6-1448440368.874188-1470675506', 00:38:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:38:10 INFO - '_': '/tools/buildbot/bin/python'} 00:38:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:38:10 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 00:38:10 INFO - Cleaning up... 00:38:10 INFO - Return code: 0 00:38:10 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 00:38:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:38:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:38:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:38:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:38:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:38:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:38:10 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 0x22e3030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24448a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2510c70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x259fe50>, '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 0x25a0d50>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25a11e0>, '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': 'e10134013339c31d8d0c4708000001d6-1448440368.874188-1470675506', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 00:38:10 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test-pgo/build 00:38:10 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 00:38:10 INFO - Using env: {'DISPLAY': ':0', 00:38:10 INFO - 'HOME': '/home/cltbld', 00:38:10 INFO - 'LANG': 'en_US.UTF-8', 00:38:10 INFO - 'LANGUAGE': 'en_US:en', 00:38:10 INFO - 'LOGNAME': 'cltbld', 00:38:10 INFO - 'MAIL': '/var/mail/cltbld', 00:38:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:38:10 INFO - 'MOZ_NO_REMOTE': '1', 00:38:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:38:10 INFO - 'NO_EM_RESTART': '1', 00:38:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:38:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 00:38:10 INFO - 'PWD': '/builds/slave/test-pgo', 00:38:10 INFO - 'SHELL': '/bin/bash', 00:38:10 INFO - 'SHLVL': '1', 00:38:10 INFO - 'TERM': 'linux', 00:38:10 INFO - 'TMOUT': '86400', 00:38:10 INFO - 'USER': 'cltbld', 00:38:10 INFO - 'XDG_SESSION_COOKIE': 'e10134013339c31d8d0c4708000001d6-1448440368.874188-1470675506', 00:38:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:38:10 INFO - '_': '/tools/buildbot/bin/python'} 00:38:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:38:10 INFO - Downloading/unpacking psutil>=0.7.1 00:38:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:38:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:38:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:38:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:38:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:38:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:38:12 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 00:38:12 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 00:38:12 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 00:38:12 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 00:38:12 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 00:38:12 INFO - Installing collected packages: psutil 00:38:12 INFO - Running setup.py install for psutil 00:38:12 INFO - building 'psutil._psutil_linux' extension 00:38:12 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 00:38:12 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 00:38:12 INFO - building 'psutil._psutil_posix' extension 00:38:12 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 00:38:12 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 00:38:13 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 00:38:13 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 00:38:13 INFO - Successfully installed psutil 00:38:13 INFO - Cleaning up... 00:38:13 INFO - Return code: 0 00:38:13 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 00:38:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:38:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:38:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:38:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:38:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:38:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:38:13 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--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 0x22e3030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24448a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2510c70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x259fe50>, '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 0x25a0d50>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25a11e0>, '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': 'e10134013339c31d8d0c4708000001d6-1448440368.874188-1470675506', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 00:38:13 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test-pgo/build 00:38:13 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 00:38:13 INFO - Using env: {'DISPLAY': ':0', 00:38:13 INFO - 'HOME': '/home/cltbld', 00:38:13 INFO - 'LANG': 'en_US.UTF-8', 00:38:13 INFO - 'LANGUAGE': 'en_US:en', 00:38:13 INFO - 'LOGNAME': 'cltbld', 00:38:13 INFO - 'MAIL': '/var/mail/cltbld', 00:38:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:38:13 INFO - 'MOZ_NO_REMOTE': '1', 00:38:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:38:13 INFO - 'NO_EM_RESTART': '1', 00:38:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:38:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 00:38:13 INFO - 'PWD': '/builds/slave/test-pgo', 00:38:13 INFO - 'SHELL': '/bin/bash', 00:38:13 INFO - 'SHLVL': '1', 00:38:13 INFO - 'TERM': 'linux', 00:38:13 INFO - 'TMOUT': '86400', 00:38:13 INFO - 'USER': 'cltbld', 00:38:13 INFO - 'XDG_SESSION_COOKIE': 'e10134013339c31d8d0c4708000001d6-1448440368.874188-1470675506', 00:38:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:38:13 INFO - '_': '/tools/buildbot/bin/python'} 00:38:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:38:13 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 00:38:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:38:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:38:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:38:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:38:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:38:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:38:14 INFO - Downloading mozsystemmonitor-0.0.tar.gz 00:38:14 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 00:38:14 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 00:38:15 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 00:38:15 INFO - Installing collected packages: mozsystemmonitor 00:38:15 INFO - Running setup.py install for mozsystemmonitor 00:38:15 INFO - Successfully installed mozsystemmonitor 00:38:15 INFO - Cleaning up... 00:38:15 INFO - Return code: 0 00:38:15 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 00:38:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:38:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:38:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:38:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:38:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:38:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:38:15 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 0x22e3030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24448a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2510c70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x259fe50>, '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 0x25a0d50>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25a11e0>, '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': 'e10134013339c31d8d0c4708000001d6-1448440368.874188-1470675506', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 00:38:15 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test-pgo/build 00:38:15 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 00:38:15 INFO - Using env: {'DISPLAY': ':0', 00:38:15 INFO - 'HOME': '/home/cltbld', 00:38:15 INFO - 'LANG': 'en_US.UTF-8', 00:38:15 INFO - 'LANGUAGE': 'en_US:en', 00:38:15 INFO - 'LOGNAME': 'cltbld', 00:38:15 INFO - 'MAIL': '/var/mail/cltbld', 00:38:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:38:15 INFO - 'MOZ_NO_REMOTE': '1', 00:38:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:38:15 INFO - 'NO_EM_RESTART': '1', 00:38:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:38:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 00:38:15 INFO - 'PWD': '/builds/slave/test-pgo', 00:38:15 INFO - 'SHELL': '/bin/bash', 00:38:15 INFO - 'SHLVL': '1', 00:38:15 INFO - 'TERM': 'linux', 00:38:15 INFO - 'TMOUT': '86400', 00:38:15 INFO - 'USER': 'cltbld', 00:38:15 INFO - 'XDG_SESSION_COOKIE': 'e10134013339c31d8d0c4708000001d6-1448440368.874188-1470675506', 00:38:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:38:15 INFO - '_': '/tools/buildbot/bin/python'} 00:38:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:38:15 INFO - Downloading/unpacking blobuploader==1.2.4 00:38:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:38:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:38:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:38:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:38:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:38:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:38:17 INFO - Downloading blobuploader-1.2.4.tar.gz 00:38:17 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 00:38:17 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 00:38:17 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 00:38:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:38:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:38:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:38:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:38:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:38:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:38:17 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 00:38:17 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 00:38:17 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 00:38:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:38:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:38:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:38:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:38:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:38:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:38:17 INFO - Downloading docopt-0.6.1.tar.gz 00:38:17 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 00:38:17 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 00:38:17 INFO - Installing collected packages: blobuploader, requests, docopt 00:38:17 INFO - Running setup.py install for blobuploader 00:38:17 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 00:38:17 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 00:38:17 INFO - Running setup.py install for requests 00:38:18 INFO - Running setup.py install for docopt 00:38:18 INFO - Successfully installed blobuploader requests docopt 00:38:18 INFO - Cleaning up... 00:38:18 INFO - Return code: 0 00:38:18 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 00:38:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:38:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:38:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:38:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:38:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:38:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:38:18 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 0x22e3030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24448a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2510c70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x259fe50>, '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 0x25a0d50>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25a11e0>, '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': 'e10134013339c31d8d0c4708000001d6-1448440368.874188-1470675506', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 00:38:18 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/config 00:38:18 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --no-deps --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 00:38:18 INFO - Using env: {'DISPLAY': ':0', 00:38:18 INFO - 'HOME': '/home/cltbld', 00:38:18 INFO - 'LANG': 'en_US.UTF-8', 00:38:18 INFO - 'LANGUAGE': 'en_US:en', 00:38:18 INFO - 'LOGNAME': 'cltbld', 00:38:18 INFO - 'MAIL': '/var/mail/cltbld', 00:38:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:38:18 INFO - 'MOZ_NO_REMOTE': '1', 00:38:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:38:18 INFO - 'NO_EM_RESTART': '1', 00:38:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:38:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 00:38:18 INFO - 'PWD': '/builds/slave/test-pgo', 00:38:18 INFO - 'SHELL': '/bin/bash', 00:38:18 INFO - 'SHLVL': '1', 00:38:18 INFO - 'TERM': 'linux', 00:38:18 INFO - 'TMOUT': '86400', 00:38:18 INFO - 'USER': 'cltbld', 00:38:18 INFO - 'XDG_SESSION_COOKIE': 'e10134013339c31d8d0c4708000001d6-1448440368.874188-1470675506', 00:38:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:38:18 INFO - '_': '/tools/buildbot/bin/python'} 00:38:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:38:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 00:38:18 INFO - Running setup.py (path:/tmp/pip-B8Vy4l-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 00:38:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 00:38:18 INFO - Running setup.py (path:/tmp/pip-zpApjR-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 00:38:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 00:38:18 INFO - Running setup.py (path:/tmp/pip-4myju0-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 00:38:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 00:38:18 INFO - Running setup.py (path:/tmp/pip-SGYfGT-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 00:38:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 00:38:18 INFO - Running setup.py (path:/tmp/pip-gB6t9_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 00:38:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 00:38:18 INFO - Running setup.py (path:/tmp/pip-anuEK5-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 00:38:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 00:38:19 INFO - Running setup.py (path:/tmp/pip-DSoJIS-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 00:38:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 00:38:19 INFO - Running setup.py (path:/tmp/pip-H1zqxD-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 00:38:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 00:38:19 INFO - Running setup.py (path:/tmp/pip-_ctgv2-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 00:38:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 00:38:19 INFO - Running setup.py (path:/tmp/pip-1kfd9H-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 00:38:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 00:38:19 INFO - Running setup.py (path:/tmp/pip-BmqJOq-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 00:38:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 00:38:19 INFO - Running setup.py (path:/tmp/pip-iekVzB-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 00:38:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 00:38:19 INFO - Running setup.py (path:/tmp/pip-YUhAom-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 00:38:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 00:38:19 INFO - Running setup.py (path:/tmp/pip-4clpt0-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 00:38:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 00:38:19 INFO - Running setup.py (path:/tmp/pip-_gyaa8-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 00:38:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 00:38:19 INFO - Running setup.py (path:/tmp/pip-S4PPSO-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 00:38:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 00:38:19 INFO - Running setup.py (path:/tmp/pip-qqhxUS-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 00:38:19 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 00:38:19 INFO - Running setup.py install for manifestparser 00:38:19 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 00:38:19 INFO - Running setup.py install for mozcrash 00:38:20 INFO - Running setup.py install for mozdebug 00:38:20 INFO - Running setup.py install for mozdevice 00:38:20 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 00:38:20 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 00:38:20 INFO - Running setup.py install for mozfile 00:38:20 INFO - Running setup.py install for mozhttpd 00:38:20 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 00:38:20 INFO - Running setup.py install for mozinfo 00:38:20 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 00:38:20 INFO - Running setup.py install for mozInstall 00:38:20 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 00:38:20 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 00:38:20 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 00:38:20 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 00:38:20 INFO - Running setup.py install for mozleak 00:38:20 INFO - Running setup.py install for mozlog 00:38:20 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 00:38:20 INFO - Running setup.py install for moznetwork 00:38:20 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 00:38:20 INFO - Running setup.py install for mozprocess 00:38:21 INFO - Running setup.py install for mozprofile 00:38:21 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 00:38:21 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 00:38:21 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 00:38:21 INFO - Running setup.py install for mozrunner 00:38:21 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 00:38:21 INFO - Running setup.py install for mozscreenshot 00:38:21 INFO - Running setup.py install for moztest 00:38:21 INFO - Running setup.py install for mozversion 00:38:21 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 00:38:21 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 00:38:21 INFO - Cleaning up... 00:38:21 INFO - Return code: 0 00:38:21 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 00:38:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:38:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:38:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:38:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:38:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:38:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:38:21 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 0x22e3030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24448a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2510c70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x259fe50>, '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 0x25a0d50>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25a11e0>, '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': 'e10134013339c31d8d0c4708000001d6-1448440368.874188-1470675506', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 00:38:21 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/config 00:38:21 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 00:38:21 INFO - Using env: {'DISPLAY': ':0', 00:38:21 INFO - 'HOME': '/home/cltbld', 00:38:21 INFO - 'LANG': 'en_US.UTF-8', 00:38:21 INFO - 'LANGUAGE': 'en_US:en', 00:38:21 INFO - 'LOGNAME': 'cltbld', 00:38:21 INFO - 'MAIL': '/var/mail/cltbld', 00:38:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:38:21 INFO - 'MOZ_NO_REMOTE': '1', 00:38:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:38:21 INFO - 'NO_EM_RESTART': '1', 00:38:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:38:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 00:38:21 INFO - 'PWD': '/builds/slave/test-pgo', 00:38:21 INFO - 'SHELL': '/bin/bash', 00:38:21 INFO - 'SHLVL': '1', 00:38:21 INFO - 'TERM': 'linux', 00:38:21 INFO - 'TMOUT': '86400', 00:38:21 INFO - 'USER': 'cltbld', 00:38:21 INFO - 'XDG_SESSION_COOKIE': 'e10134013339c31d8d0c4708000001d6-1448440368.874188-1470675506', 00:38:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:38:21 INFO - '_': '/tools/buildbot/bin/python'} 00:38:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:38:21 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 00:38:21 INFO - Running setup.py (path:/tmp/pip-Fd9yYG-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 00:38:21 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 1)) 00:38:21 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 00:38:21 INFO - Running setup.py (path:/tmp/pip-lqxpmM-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 00:38:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.16 from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 00:38:21 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 00:38:21 INFO - Running setup.py (path:/tmp/pip-uT8BPo-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 00:38:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 3)) 00:38:22 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 00:38:22 INFO - Running setup.py (path:/tmp/pip-KNOp91-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 00:38:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.47 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 00:38:22 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 00:38:22 INFO - Running setup.py (path:/tmp/pip-2V8wTw-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 00:38:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 5)) 00:38:22 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 00:38:22 INFO - Running setup.py (path:/tmp/pip-iG7ey6-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 00:38:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 6)) 00:38:22 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 00:38:22 INFO - Running setup.py (path:/tmp/pip-nncf7f-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 00:38:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 7)) 00:38:22 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 00:38:22 INFO - Running setup.py (path:/tmp/pip-XxA8Bc-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 00:38:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 8)) 00:38:22 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 00:38:22 INFO - Running setup.py (path:/tmp/pip-mx9Tth-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 00:38:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 9)) 00:38:22 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 00:38:22 INFO - Running setup.py (path:/tmp/pip-3Y7GdF-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 00:38:22 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)) 00:38:22 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 00:38:22 INFO - Running setup.py (path:/tmp/pip-c0ouRC-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 00:38:22 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 11)) 00:38:22 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 00:38:22 INFO - Running setup.py (path:/tmp/pip-S6aT6V-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 00:38:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 12)) 00:38:22 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 00:38:22 INFO - Running setup.py (path:/tmp/pip-8_LwdC-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 00:38:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.27 from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 13)) 00:38:22 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 00:38:22 INFO - Running setup.py (path:/tmp/pip-B1r5L7-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 00:38:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 14)) 00:38:22 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 00:38:22 INFO - Running setup.py (path:/tmp/pip-11RHSP-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 00:38:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 15)) 00:38:22 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 00:38:22 INFO - Running setup.py (path:/tmp/pip-oAz215-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 00:38:22 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test-pgo/build/tests/mozbase/moztest in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 16)) 00:38:22 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 00:38:22 INFO - Running setup.py (path:/tmp/pip-8QCJH1-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 00:38:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 17)) 00:38:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 00:38:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 00:38:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 3)) 00:38:23 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 00:38:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 00:38:23 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 00:38:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:38:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:38:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:38:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:38:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:38:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:38:24 INFO - Downloading blessings-1.5.1.tar.gz 00:38:24 INFO - Storing download in cache at /builds/slave/test-pgo/build/venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblessings-1.5.1.tar.gz 00:38:24 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 00:38:24 INFO - Installing collected packages: blessings 00:38:24 INFO - Running setup.py install for blessings 00:38:24 INFO - Successfully installed blessings 00:38:24 INFO - Cleaning up... 00:38:24 INFO - Return code: 0 00:38:24 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 00:38:24 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 00:38:24 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 00:38:25 INFO - Reading from file tmpfile_stdout 00:38:25 INFO - Current package versions: 00:38:25 INFO - argparse == 1.2.1 00:38:25 INFO - blessings == 1.5.1 00:38:25 INFO - blobuploader == 1.2.4 00:38:25 INFO - docopt == 0.6.1 00:38:25 INFO - manifestparser == 1.1 00:38:25 INFO - mozInstall == 1.12 00:38:25 INFO - mozcrash == 0.16 00:38:25 INFO - mozdebug == 0.1 00:38:25 INFO - mozdevice == 0.47 00:38:25 INFO - mozfile == 1.2 00:38:25 INFO - mozhttpd == 0.7 00:38:25 INFO - mozinfo == 0.9 00:38:25 INFO - mozleak == 0.1 00:38:25 INFO - mozlog == 3.1 00:38:25 INFO - moznetwork == 0.27 00:38:25 INFO - mozprocess == 0.22 00:38:25 INFO - mozprofile == 0.27 00:38:25 INFO - mozrunner == 6.11 00:38:25 INFO - mozscreenshot == 0.1 00:38:25 INFO - mozsystemmonitor == 0.0 00:38:25 INFO - moztest == 0.7 00:38:25 INFO - mozversion == 1.4 00:38:25 INFO - psutil == 3.1.1 00:38:25 INFO - requests == 1.2.3 00:38:25 INFO - wsgiref == 0.1.2 00:38:25 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 00:38:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:38:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:38:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:38:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:38:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:38:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:38:25 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/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 0x22e3030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24448a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2510c70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x259fe50>, '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 0x25a0d50>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25a11e0>, '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': 'e10134013339c31d8d0c4708000001d6-1448440368.874188-1470675506', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 00:38:25 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/talos 00:38:25 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 -r /builds/slave/test-pgo/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 00:38:25 INFO - Using env: {'DISPLAY': ':0', 00:38:25 INFO - 'HOME': '/home/cltbld', 00:38:25 INFO - 'LANG': 'en_US.UTF-8', 00:38:25 INFO - 'LANGUAGE': 'en_US:en', 00:38:25 INFO - 'LOGNAME': 'cltbld', 00:38:25 INFO - 'MAIL': '/var/mail/cltbld', 00:38:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:38:25 INFO - 'MOZ_NO_REMOTE': '1', 00:38:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:38:25 INFO - 'NO_EM_RESTART': '1', 00:38:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:38:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 00:38:25 INFO - 'PWD': '/builds/slave/test-pgo', 00:38:25 INFO - 'SHELL': '/bin/bash', 00:38:25 INFO - 'SHLVL': '1', 00:38:25 INFO - 'TERM': 'linux', 00:38:25 INFO - 'TMOUT': '86400', 00:38:25 INFO - 'USER': 'cltbld', 00:38:25 INFO - 'XDG_SESSION_COOKIE': 'e10134013339c31d8d0c4708000001d6-1448440368.874188-1470675506', 00:38:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:38:25 INFO - '_': '/tools/buildbot/bin/python'} 00:38:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:38:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 00:38:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 2)) 00:38:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 3)) 00:38:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 4)) 00:38:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 5)) 00:38:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 6)) 00:38:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 7)) 00:38:25 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 8)) 00:38:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash>=0.15->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 00:38:25 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 3)) 00:38:25 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozlog>=3.0->mozcrash>=0.15->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 00:38:25 INFO - Cleaning up... 00:38:25 INFO - Return code: 0 00:38:25 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 00:38:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:38:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:38:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:38:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:38:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:38:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:38:25 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22e3030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24448a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2510c70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x259fe50>, '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 0x25a0d50>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25a11e0>, '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': 'e10134013339c31d8d0c4708000001d6-1448440368.874188-1470675506', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 00:38:25 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', 'jsonschema'] in /builds/slave/test-pgo/build 00:38:25 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 jsonschema 00:38:25 INFO - Using env: {'DISPLAY': ':0', 00:38:25 INFO - 'HOME': '/home/cltbld', 00:38:25 INFO - 'LANG': 'en_US.UTF-8', 00:38:25 INFO - 'LANGUAGE': 'en_US:en', 00:38:25 INFO - 'LOGNAME': 'cltbld', 00:38:25 INFO - 'MAIL': '/var/mail/cltbld', 00:38:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:38:25 INFO - 'MOZ_NO_REMOTE': '1', 00:38:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:38:25 INFO - 'NO_EM_RESTART': '1', 00:38:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:38:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 00:38:25 INFO - 'PWD': '/builds/slave/test-pgo', 00:38:25 INFO - 'SHELL': '/bin/bash', 00:38:25 INFO - 'SHLVL': '1', 00:38:25 INFO - 'TERM': 'linux', 00:38:25 INFO - 'TMOUT': '86400', 00:38:25 INFO - 'USER': 'cltbld', 00:38:25 INFO - 'XDG_SESSION_COOKIE': 'e10134013339c31d8d0c4708000001d6-1448440368.874188-1470675506', 00:38:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:38:25 INFO - '_': '/tools/buildbot/bin/python'} 00:38:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:38:25 INFO - Downloading/unpacking jsonschema 00:38:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:38:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:38:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:38:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:38:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:38:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:38:27 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 00:38:27 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fjsonschema-2.5.1-py2.py3-none-any.whl 00:38:27 INFO - Downloading/unpacking functools32 (from jsonschema) 00:38:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:38:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:38:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:38:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:38:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:38:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:38:27 INFO - Downloading functools32-3.2.3-2.tar.gz 00:38:27 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 00:38:27 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 00:38:27 INFO - warning: no files found matching '*.txt' 00:38:27 INFO - no previously-included directories found matching 'build' 00:38:27 INFO - no previously-included directories found matching 'dist' 00:38:27 INFO - no previously-included directories found matching '.git*' 00:38:27 INFO - Installing collected packages: jsonschema, functools32 00:38:27 INFO - Running setup.py install for functools32 00:38:27 INFO - warning: no files found matching '*.txt' 00:38:27 INFO - no previously-included directories found matching 'build' 00:38:27 INFO - no previously-included directories found matching 'dist' 00:38:27 INFO - no previously-included directories found matching '.git*' 00:38:27 INFO - Successfully installed jsonschema functools32 00:38:27 INFO - Cleaning up... 00:38:27 INFO - Return code: 0 00:38:27 INFO - Running post-action listener: _resource_record_post_action 00:38:27 INFO - Running post-action listener: _start_resource_monitoring 00:38:27 INFO - Starting resource monitoring. 00:38:27 INFO - ##### 00:38:27 INFO - ##### Running install step. 00:38:27 INFO - ##### 00:38:27 INFO - Running pre-action listener: _resource_record_pre_action 00:38:27 INFO - Running main action method: install 00:38:27 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 00:38:27 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 00:38:28 INFO - Reading from file tmpfile_stdout 00:38:28 INFO - Detecting whether we're running mozinstall >=1.0... 00:38:28 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 00:38:28 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 00:38:28 INFO - Reading from file tmpfile_stdout 00:38:28 INFO - Output received: 00:38:28 INFO - Usage: mozinstall [options] installer 00:38:28 INFO - Options: 00:38:28 INFO - -h, --help show this help message and exit 00:38:28 INFO - -d DEST, --destination=DEST 00:38:28 INFO - Directory to install application into. [default: 00:38:28 INFO - "/builds/slave/test-pgo"] 00:38:28 INFO - --app=APP Application being installed. [default: firefox] 00:38:28 INFO - mkdir: /builds/slave/test-pgo/build/application 00:38:28 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test-pgo/build/application'] 00:38:28 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test-pgo/build/application 00:38:42 INFO - Reading from file tmpfile_stdout 00:38:42 INFO - Output received: 00:38:42 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 00:38:42 INFO - Running post-action listener: _resource_record_post_action 00:38:42 INFO - ##### 00:38:42 INFO - ##### Running run-tests step. 00:38:42 INFO - ##### 00:38:42 INFO - Running pre-action listener: _resource_record_pre_action 00:38:42 INFO - Running main action method: run_tests 00:38:42 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 00:38:42 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 00:38:42 INFO - Python 2.7.3 00:38:42 INFO - Return code: 0 00:38:42 INFO - grabbing minidump binary from tooltool 00:38:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:38:42 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 0x259fe50>, '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 0x25a0d50>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25a11e0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 00:38:42 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test-pgo/build 00:38:42 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 00:38:42 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 00:38:42 INFO - Return code: 0 00:38:42 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 00:38:42 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 00:38:42 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 00:38:42 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 00:38:42 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 00:38:42 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/px5GceqESrG3iOAqINa-1w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-023', '--webServer', 'localhost'] in /builds/slave/test-pgo/build 00:38:42 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --debug --branchName Mozilla-Inbound --suite dromaeojs --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/px5GceqESrG3iOAqINa-1w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-023 --webServer localhost 00:38:42 INFO - Using env: {'DISPLAY': ':0', 00:38:42 INFO - 'HOME': '/home/cltbld', 00:38:42 INFO - 'LANG': 'en_US.UTF-8', 00:38:42 INFO - 'LANGUAGE': 'en_US:en', 00:38:42 INFO - 'LOGNAME': 'cltbld', 00:38:42 INFO - 'MAIL': '/var/mail/cltbld', 00:38:42 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 00:38:42 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 00:38:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:38:42 INFO - 'MOZ_NO_REMOTE': '1', 00:38:42 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 00:38:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:38:42 INFO - 'NO_EM_RESTART': '1', 00:38:42 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:38:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 00:38:42 INFO - 'PWD': '/builds/slave/test-pgo', 00:38:42 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 00:38:42 INFO - 'SHELL': '/bin/bash', 00:38:42 INFO - 'SHLVL': '1', 00:38:42 INFO - 'TERM': 'linux', 00:38:42 INFO - 'TMOUT': '86400', 00:38:42 INFO - 'USER': 'cltbld', 00:38:42 INFO - 'XDG_SESSION_COOKIE': 'e10134013339c31d8d0c4708000001d6-1448440368.874188-1470675506', 00:38:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:38:42 INFO - '_': '/tools/buildbot/bin/python'} 00:38:42 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/px5GceqESrG3iOAqINa-1w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-023', '--webServer', 'localhost'] with output_timeout 3600 00:38:42 INFO - mozversion INFO | application_buildid: 20151124223107 00:38:42 INFO - mozversion INFO | application_changeset: 8021382da9722db0ad97ebd93698b69a74f0d9b0 00:38:42 INFO - mozversion INFO | application_display_name: Nightly 00:38:42 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 00:38:42 INFO - mozversion INFO | application_name: Firefox 00:38:42 INFO - mozversion INFO | application_remotingname: firefox 00:38:42 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/mozilla-inbound 00:38:42 INFO - mozversion INFO | application_vendor: Mozilla 00:38:42 INFO - mozversion INFO | application_version: 45.0a1 00:38:42 INFO - mozversion INFO | platform_buildid: 20151124223107 00:38:42 INFO - mozversion INFO | platform_changeset: 8021382da9722db0ad97ebd93698b69a74f0d9b0 00:38:42 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 00:38:42 INFO - mozversion INFO | platform_version: 45.0a1 00:38:42 INFO - 2015-11-25 00:38:42,971 DEBUG : using testdate: 1448440722 00:38:42 INFO - 2015-11-25 00:38:42,971 DEBUG : actual date: 1448440722 00:38:42 INFO - 2015-11-25 00:38:42,979 INFO : starting webserver on 'localhost:48777' 00:38:42 INFO - 2015-11-25 00:38:42,980 INFO : Starting test suite talos-linux64-ix-023 00:38:42 INFO - 2015-11-25 00:38:42,980 INFO : Starting test dromaeo_css 00:38:42 INFO - 2015-11-25 00:38:42,980 DEBUG : operating with platform_type : linux_ 00:38:42 INFO - 2015-11-25 00:38:42,981 INFO : Initialising browser for dromaeo_css test... 00:38:42 INFO - 2015-11-25 00:38:42,995 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpKZTiEn/profile http://localhost:48777/getInfo.html 00:38:47 INFO - 2015-11-25 00:38:47,029 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 00:38:47 INFO - 2015-11-25 00:38:47,029 DEBUG : BROWSER_OUTPUT: colorDepth:24 00:38:47 INFO - 2015-11-25 00:38:47,029 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 00:38:47 INFO - 2015-11-25 00:38:47,030 DEBUG : BROWSER_OUTPUT: __metrics 00:38:47 INFO - 2015-11-25 00:38:47,187 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 00:38:48 INFO - 2015-11-25 00:38:48,364 INFO : Browser initialized. 00:38:48 INFO - 2015-11-25 00:38:48,365 INFO : Running cycle 1/1 for dromaeo_css test... 00:38:48 INFO - 2015-11-25 00:38:48,365 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpKZTiEn/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 00:39:00 INFO - 2015-11-25 00:39:00,104 DEBUG : BROWSER_OUTPUT: RSS: Main: 139776000 00:39:00 INFO - 2015-11-25 00:39:00,104 DEBUG : BROWSER_OUTPUT: 00:39:50 INFO - 2015-11-25 00:39:50,793 DEBUG : BROWSER_OUTPUT: 1448440790792 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 00:42:00 INFO - 2015-11-25 00:42:00,700 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:48777/tests/dromaeo/cssquery-dojo.html (next: http://localhost:48777/tests/dromaeo/cssquery-ext.html) 00:42:01 INFO - 2015-11-25 00:42:01,810 DEBUG : BROWSER_OUTPUT: RSS: Main: 249511936 00:42:01 INFO - 2015-11-25 00:42:01,810 DEBUG : BROWSER_OUTPUT: 00:45:04 INFO - 2015-11-25 00:45:04,159 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:48777/tests/dromaeo/cssquery-ext.html (next: http://localhost:48777/tests/dromaeo/cssquery-jquery.html) 00:45:04 INFO - 2015-11-25 00:45:04,732 DEBUG : BROWSER_OUTPUT: RSS: Main: 224473088 00:45:04 INFO - 2015-11-25 00:45:04,732 DEBUG : BROWSER_OUTPUT: 00:48:06 INFO - 2015-11-25 00:48:06,701 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:48777/tests/dromaeo/cssquery-jquery.html (next: http://localhost:48777/tests/dromaeo/cssquery-mootools.html) 00:48:07 INFO - 2015-11-25 00:48:07,274 DEBUG : BROWSER_OUTPUT: RSS: Main: 226508800 00:48:07 INFO - 2015-11-25 00:48:07,274 DEBUG : BROWSER_OUTPUT: 00:51:09 INFO - 2015-11-25 00:51:09,215 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:48777/tests/dromaeo/cssquery-mootools.html (next: http://localhost:48777/tests/dromaeo/cssquery-prototype.html) 00:51:09 INFO - 2015-11-25 00:51:09,816 DEBUG : BROWSER_OUTPUT: RSS: Main: 198160384 00:51:09 INFO - 2015-11-25 00:51:09,816 DEBUG : BROWSER_OUTPUT: 00:54:12 INFO - 2015-11-25 00:54:12,293 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:48777/tests/dromaeo/cssquery-prototype.html (next: http://localhost:48777/tests/dromaeo/cssquery-yui.html) 00:54:12 INFO - 2015-11-25 00:54:12,867 DEBUG : BROWSER_OUTPUT: RSS: Main: 205246464 00:54:12 INFO - 2015-11-25 00:54:12,867 DEBUG : BROWSER_OUTPUT: 00:57:15 INFO - 2015-11-25 00:57:15,333 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:48777/tests/dromaeo/cssquery-yui.html (next: http://localhost:48777/tests/dromaeo/cssquery-dojo.html) 00:57:15 INFO - 2015-11-25 00:57:15,584 DEBUG : BROWSER_OUTPUT: RSS: Main: 271327232 00:57:15 INFO - 2015-11-25 00:57:15,584 DEBUG : BROWSER_OUTPUT: 00:57:15 INFO - 2015-11-25 00:57:15,585 DEBUG : BROWSER_OUTPUT: __start_tp_report 00:57:15 INFO - 2015-11-25 00:57:15,585 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 00:57:15 INFO - 2015-11-25 00:57:15,586 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 00:57:15 INFO - 2015-11-25 00:57:15,586 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 00:57:15 INFO - 2015-11-25 00:57:15,587 DEBUG : BROWSER_OUTPUT: |0;dojo.html;3195.281061761104;3258.67413258674;3284.178955261185;3290.670932906711;3311.122552523581;5239.895202095956;5370.973145134279;5412.702301373423;5431.918521222185;5437.293151890253;5414.187871819219;5427.294451721271;5484.725763711808;5492.835214943558;5514.641548299358;4841.685290456118;4852.2479015752615;4860.416749989989;4871.050145221683;4953.702777833323;4795.040991801636;5043.193089105744;5054.21659642756;5055.31753213317;5114.079465696173;4789.880252993686;4918.803247870081;4928.852134435972;4929.211326187793;4946.802127914879;4965.255211718235;4978.00439912019;4980.228064649985;4987.426445958725;5015.824446144404;4752.07334569759;4954.529319714621;4962.578180854632;4965.131102057126;5024.346834911475;5126.512981266774;5150.227465880111;5254.054270231357;5279.234510995884;5281.947180528184;5831.358550559435;5839;5846.356900740915;5846.853828654318;5848.736806843703;5738.598298119134;5872.559558033122;5885.970570147165;5887.411258874121;5888.263967004124;5434.184872269152;5444.237806707064;5490.396056433789;5628.240187574707;5628.71856407178;6003.909941350883;6050.031994880798;6051.394860514001;6070.817875463743;6080.75676972925;5715.457031581993;5822.534197264294;5823.679697616587;5824.446677565625;5864.560157988168;5699.886002279931;5818.156367326798;5818.796342128006;5906.084556893688;5923.437273459014;5949.137375080676;5953.464188223081;5955.672438015864;5956.463918247378;5986.73059712314;5927.466528012414;5940.61386009908;5941.257342832146;5943.3462319144855;5944.256967879015;4326.63223625989;4413.426254586883;4451.132029254329;4557.840475583405;4560.3843481129625;4021.738586991895;4048.4129801178665;4053.250148722496;4054.716169868081;4096.05790668148;5585.776568937197;5585.944140558624;5586.748596313176;5587.38538760736;5615.129654903497;5748.425157484218;5807.68057756819;5868.119782032729;5870.911936320958;5983.1623572699855;5543.029969755276;5581.49766521015;5584;5596.412376700469;5598.832035038955;5110.514501122388;5113.181890897438;5140.203268493389;5144.331236939174;5189.6107791915;5856.209411729447;5943.554233432596;5949.315828679671;6083.665398403042;6089.117078023662;5712.285964254468;5773.566982476415;5801.883962320646;5809.157672137601;5822.388649191943;6029.51763858899;6035.39646035393;6041.909371359346;6043.969780151247;6061.909071364022;5680.971595142163;5744.741486633028;5757.568182386254;5778.306603207642;5781.4507621775865;5770.365259821332;5773.1051686988585;5864.06175011996;5901.380355062828;5909.261342332208;5704.1443783432815;5793.420657934173;5798.043322851851;5798.623089499169;5802.4197580241635;5377.3816011159215;5656.264685590847;5666.433356664301;5673.858153546194;5674.602777805679;5440.863978400572;5479.6164268500825;5558.583106266965;5566.944330556643;5611.719414029364;5696.487316141567;5699.5155411790465;5713.542916566582;5742.08126699726;5793.304803423616;5409.648372855751;5531.2532808072;5599.496045355938;5622.353429355513;5628.774849005994 00:57:15 INFO - 2015-11-25 00:57:15,591 DEBUG : BROWSER_OUTPUT: |1;ext.html;561.3572459533834;596.9253843269591;609.1776102261946;613;615.0651010464092;31052;40389;41029.79485102578;41052.58947410533;41058.79470602646;43294.78352608233;43499.34750978738;43629;43775.78112109443;43932;7529.058867641545;7649.923500765005;8604.26863716585;8856.424332418372;8894.199522043014;10185.541650625739;10359.948200258988;10390.844137337946;10396.168306535497;10405.583776648926;10175;10281.948590257038;10285.691429257135;10288;10294.588216471333;7741.5355078695175;7922.405819563556;7922.960385198095;7926.960365198195;10129.89870101297;10405.427701476416;10686.893131068668;10689.893101069045;10693.679189624323;10699.78600427995;40186;40473;40521.79739101315;40570;40595;3127.9530807037913;3206.8556914938886;3349.531065650811;3351.731861451078;3631.346357655621;30298.69701303003;30739.231519211975;30795.692043079507;30895.227619309473;31668;3586.497890295361;3597.784132952031;3612.638736126393;3659.597444281127;3747.681447077002;263837;265840;266222.6688866563;266281;266367;58589;59549.129306594936;60120.398796012356;65915;66773.3322666767;61661.38338616646;61902.69048654728;62003.689981550706;62079;62239;15981.760273595906;16138.354465821236;16156.434524791575;16161.676766464605;16172.75740863888;12403.379831008413;12426.192297500633;12449.377531123408;12451.501939922482;12533.811992820116;20325.390238292875;20462.79537204609;20631.896840515703;20683.06926188325;20792.792072079086;7987.880181797278;8134.145914678874;8247.793805154919;8248.731598810255;8264.380171487162;938.5729493080632;979.5298256836616;1039.5633833789827;1056.8784589772274;1101.4107452512867;27900.441991160063;28305.292367690974;28619.57070643942;32032.519512207335;33136.50295245573;985.8866230383454;1019.4189312092036;1049.2969710294121;1083.8807731149568;1119.4626579241847;14800.407983680747;15016.47442339513;15087.094774313577;15243.23783810805;15280.923595381952;396745;403871;404325;405123;405253;53363.733181334625;54108.188377174374;54136.45863541393;54157.72921135369;54268;1340.825692659948;1348.5549768576345;1354.837419509665;1369.274284629148;1376.4081444978556;27270.181894543195;28337.574936375557;28393.858030709715;28408.57387139153;28472.430551389272;45137.77431112823;45545.089098217184;45749;45749.595056691425;45793.77103114463;289582;291380;291512;291784;291978;27201.86399067992;30362.696373035986;30658.84670576633;30795.38409231758;31038.22404439907;36864.63135368612;38109.4283585752;38237.617623823404;38239.61760382361;38282;33394.666053339155;33838.154046149044;34589.48115778316;34671.82664086663;35017;34042.65957340395;34306;34506.82746586251;34700;35015.64984350124;33536.329273414885;34511.30977380388;34617.82691086629;34777.30445391129;34877;28347.716522834507;29875.402491949604;31312.530312045794;31492;31560;24251.052797218545;24310.878445607657;24371.634425483986;24373.63439548373;24576.385590360384 00:57:15 INFO - 2015-11-25 00:57:15,591 DEBUG : BROWSER_OUTPUT: |2;jquery.html;349.77789103919;352.75131032622005;354.24015486780854;356.3265428340437;357.81930125286726;16115.194240287983;16378.508644740647;17002.234899429524;17144.485665430027;17152.313907443717;17261.223244953977;17416.129193540335;17420.39028633998;17467;17656.205470753815;5216.478352164791;5236.450172731856;5331.173668081454;5370.91943620846;5373.596980226479;5258.526732594066;5319.760610772524;5328.5470734987575;5330.733463326837;5335.013022590813;3915.3343931531567;3934.4688467057013;4368.97815510922;5292.629515933886;5298.0993231150605;5764.221830052952;5765.019946609086;5786.334571524287;5790.913136302959;5805.274340707411;4861.343718597979;5108.7445627718835;5110.8466745997675;5111.539961403454;5112.926285480054;10871.782564348669;11154.832677509843;11220.66338009861;11225.887741122566;12478;1698.8046374666949;1859.3771086685977;1885.4909174522938;1984.8015198480182;2191.375457994464;9286.814263714688;9475;9533.332666713333;9834.9508252459;12474.126811123226;1788.5618023584175;1849.9352522661643;1863.6738570750065;1873.3443294846832;1883.8775479593783;42784.93037674052;51121;56506.71746641282;58509.7074514629;59468.70265648644;9885;10263.897361026295;10292.382457052601;10317;10362.119219866245;13273.203607783564;13333.20000799955;13344.866551334362;13345.73308533824;13346.199228046155;7050.4007159391;7134.429245660334;7385.4460915431555;7442.18136005039;7488.51324663906;7024.192217894905;7025.121859767529;7057.576545407292;7064.152301723723;7072;4318.222719910384;4385.780710964439;4420.9336859947125;4433.911321773547;4451.354553589711;1763.3916298876868;1782.910854457298;1826.9269229230947;1828.772217036931;1843.2811203630595;901.1304091551684;915.1946287267162;942.4392486470539;1060.8355704865758;1063.1016790811752;16161;16807.747883781754;16885.746713799304;17139.14304284781;17206.827931720774;889.7419748273057;931.0596297739332;993.7118235711707;994.9900500994897;995.2585323933571;9042.728718138467;9303.906960930439;9836.508174591241;9887.851682224773;9899.455529945923;420668;423615;461167;472069;472129;74545.6272718633;77472.61263693645;78111.00136681518;78872.21127788763;79451.60274198592;1097.0948967102172;1118.7426891814928;1126.2060247525476;1137.38581166171;1154.5785788187252;12009.939950300542;13442.193468391928;14600.342984565508;15003.77494337564;15390.153541554873;34841.65158348384;35413.46879796754;35421.11447213737;35588.644113558534;35798;44560.77719611511;44895.77552112219;45077.873053173935;45871.31193032041;47784.761076194394;9192.908070919206;9272.119148680864;9305.255579553756;9322.860157097784;9355.549889767097;13240.337983100999;16492.34030638761;16883.40908068261;16910.32358705687;17064.744028839825;13495.865041349462;13540.864591354355;14063.367148478139;14231.430742770173;14469.782953255499;13432.865671343552;13697.383617737027;13698.931505342409;13852.93073534626;13965.58103256904;14370.928145359207;14377.712445751236;14627;14699.338529765972;14961;8873.890763654543;8906.376553641183;9038.322125840457;9164.358494905293;9164.862527061967;13990.650233744238;14150.858491414954;14157.292135392983;14231.217283049531;14644.707105858037 00:57:15 INFO - 2015-11-25 00:57:15,594 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1370.7327071221116;1639.8934069285497;1696.2027846911947;1714.2457318779736;1725.1288099509745;6424;7093.929060709392;7220.530665506738;7227.385672217854;7244.7826565202995;7057.823554411142;7251.057362542862;7261.854762904752;7263.309985551364;7266.237045110267;1893.8768980016323;1929.372953790017;1934.4003358958769;2215.7230346206725;2254.977450225493;2193.21044424008;2242.192810588187;2242.7869352411576;2245.247841972941;2247.9996401601293;2125.4048866317457;2161.945951351213;2232.151782322723;2237.0604346174646;2237.44063984004;1906.6663333916579;1959.519917620185;2159.222679835258;2216.3350994701605;2228.4094714900402;2177.150911144655;2212.8340374471977;2216.789405006522;2219.622664147099;2220.0675716199235;7097.751578694721;7174.820629484252;7177.210506844243;7177.318154775288;7183.928160718378;4405.207062728708;4458.643308535309;4476.529964353761;4488.214562451558;4517.412736344254;2998.055612482061;3034.408290383376;3096.210466331094;3097.1947293703574;3105.844707764603;1028.8713910761155;1037.9532921018572;1042.9530671119742;1069.9893001069968;1083.6153165626247;9737.513124343754;9739.90260097397;9766.609335626566;9771.706848794547;9772.16936560386;4055.614716601918;4122.505299364096;4184.539700632928;4198.517170525429;4209.221294060609;8516.27611653004;8516.318694504425;8532.36007299455;8535.701250456204;8537.359698022674;4582.977085114553;4598.8620341389815;4602.240630296031;4608.539146085432;4609.9308510372375;4142.606452387018;4170.624643782075;4174;4180.163967206571;4181.6236538711055;3493.703035242033;3560.0565850049757;3567.1973805893986;3567.3222087803233;3570.4465807799834;1111.8054340490382;1127.8984891359653;1157.6179860645966;1171.9003884669728;1172.6013155526991;1009.9040591143829;1028.3264461777549;1030.443560477334;1121.472907733364;1261.211742660837;6101.938980610226;6251.093591429218;6517.608943463408;6631.900521492182;6651.301613330531;586.3608666553478;597.235538510707;603.8399824046631;641.913341698874;644.9613023218621;5038.395392552917;5068.543831055223;5088.5420312171345;5132.435432102466;5135.152699804565;8204.466709663971;8618.870716939251;8642.265407440438;8647.913520864711;8655.870161947576;8454.957725211334;8470.661173553111;8572.3999320047;8573.699920502877;8575.828483430421;6777.796666099926;6791.796246112525;6844.93155068443;6863.622500762506;6883.483738719616;6520.380563846427;6571.080048793077;6574.967125164344;6580.177477815273;6590.637514936724;7763.805904852424;7793.766187014398;7957.721479748181;7958.363330933627;7973.043234811859;7970.242826931432;8079.474834135763;8202.466839655403;8215.548144852091;8224.917750822655;6288.654124023223;6392.680365981775;6545.934540654723;6606.702698378488;6620.437262832713;6827.658617069226;6873.381395674413;6882.7591034313555;6884.449244060564;6897.62063086515;6644.501662375438;6668.466522678271;6686.364795344434;6770.661466926733;6780.084688566981;6383.96808015957;6551.21385433751;6568.441682457044;6604.8348791280605;6627.635480048643;5633.436656334334;5688.288963879515;6366.013267943476;6408.07082972957;6410.551261411656;5731.512821410227;5828.213191219301;5856.209411729362;5857.4435428634215;5858.619189752652;5899.528037757055;5941.376155503783;5945.970270148621;5949.0481522956115;5955.91066134017 00:57:15 INFO - 2015-11-25 00:57:15,595 DEBUG : BROWSER_OUTPUT: |4;prototype.html;328.41705971899887;332.4149496885481;332.86851693581036;334.9380364632543;337.31861639488227;5823.330317013545;5960.4337587929185;5989.161517387563;5996.8800623987545;6014.127951447043;5752.108423194401;5881.176635271066;5893.38119497453;5903.114532820079;5905.734241959111;4593.517680643535;4605.332226827108;4608.21660317746;4612.884677883063;4619.422572178478;4419.138268037734;4527.750973696446;4527.818887244523;4528;4607.884802879938;4466.3747075409465;4565.840195593155;4568.7944042518;4570.10882877839;4574.99350142968;4555.772211389451;4555.886102847422;4565.383673204141;4565.497795242521;4576.1762882681105;4011.0774521859844;4012.879613611567;4019.095703466726;4019.8593049243136;4025.577314381977;5478.780848766045;5606.243157173811;5608.6073974821775;5634.408387119375;5649.124385720179;5258.8159414420315;5262.158244614393;5269.815556455505;5270.7628156733035;5276;6006.609570377911;6294.968525157391;6297.905531417033;6302.401271879165;6309.589876658002;4267.271754939224;4287.785610719483;4318.762468064255;4325.956740432587;4332.241857674926;6377.808665740035;6474.093626892239;6492.285848556702;6516.152900122954;6518.902216466757;4414.536473670282;4451.3545535897765;4470.687051906335;4474.753888536096;4475.753833539186;4450.087732014929;4504.977475112669;4530.77346132692;4544.636429085665;4549.613282870927;5216.817411390583;5222.738863056832;5224.52979231871;5231.0584094862525;5242.344706911636;6246.843828904313;6282.246130464374;6319.05214217871;6319.304876463585;6323.241211054611;1586.698527279813;1598.20888660114;1606.03637817311;1610.8952918060522;1610.927508262131;1060.347886050089;1061.0874647802884;1066.4827558634056;1072.5280876414354;1073.2272763610188;6168.136460895478;6174.845628859314;6179.5056395488255;6181.258249010058;6183.74293382912;6513.739450422025;6534;6542.051402546699;6548.345165483509;6551.934480655133;5979.355677188721;6104.847378815565;6151.477124444383;6155.599886007395;6169.259688837368;3498.6151523332414;3527;3527.4179760339257;3528.647135286451;3530.293941211768;6685.598864068074;6687.431568316748;6695.163104611924;6695.330466953265;6708.530402871752;6661;6665.066890635315;6667.63328016954;6673.03241030048;6676.566023208476;6538.1500404947055;6657.434118100015;6700.329967003261;6706.094677218611;6709.19489661234;6379.266384365857;6498.252700939453;6500.5449618526245;6508.739650413931;6509.609423434609;6372.6495042773095;6488.70800813974;6503.479721622164;6519.445847103049;6525.608463492205;6787.694553745192;6787.932120678927;6788.744082344782;6789.1174147360525;6791.592504449749;4400.493943196573;4452.821887124479;4473.172463094338;4474.955250447584;4481.7535035573355;6502.544821862424;6512.185976752906;6512.218533775977;6519.054737063005;6531.216254049545;6306.905396419149;6308.400701933309;6366.522510811615;6369.331220221995;6369.458596019205;6096.65278867648;6221.720022598904;6222.377762223922;6225.28409232944;6228.564000520101;6249;6251.749930002749;6254.311335939362;6255.906161407492;6259.968700156653;6373.74505019794;6385.265694445198;6394.6482943436695;6396.168498095218;6407.711652975534;6095.481884039907;6231.314555398993;6238.313785483684;6250.1874756281395;6257.78097766576 00:57:15 INFO - 2015-11-25 00:57:15,597 DEBUG : BROWSER_OUTPUT: |5;yui.html;732.1909290234291;807.8688005227386;828.908820029797;829.1128492513012;840.2227939156282;13034.348282585868;13357.933210333947;13359.398827052783;13379.59861204163;13416.195028298309;13107.148035377693;13207.471701131943;13209.735805283888;13238.53665121721;13261.535846245384;675.5338816216819;683.8461346197091;816.6406781016364;822.3873214455239;835.5237514616671;822.6668199379261;826.0417915218347;828.8176601147737;830.3191383065888;834.3241974001079;703.2721133626698;865.5412631305387;865.7056600755742;870.2472361407368;870.8214815962713;706.015108923052;844.0420123160227;849.2950850793826;851.0043249398188;851.085083535196;635.9554831161821;636.1697984130708;636.5162476517834;638.6902352359149;639.1563136659611;13061.542846000439;13064.608061758163;13132.6716832079;13165.86834131656;13166.868331316757;11164.832527512093;11783.7054073648;11844.644660660195;11890.167688261825;11997.46011429479;9280.443173409618;9298.814023719555;9301;9358.063890036283;9435.528223588863;3417.2652879631;3466.687998080185;3471.20162362658;3482.8606855725993;3490.057684425191;43758;44703.55296447026;45250.321245181345;46432.3035154473;46482.76758616219;8475.110113438124;8635.179657932485;8648.740537783877;8655.740327790176;8691.782705432415;16485;16503.257353418885;16545.50363489097;16548.669026619402;16550.172491375382;7317.158526769384;7334.963325183447;7341.265873412723;7363.263673632594;7439.442041846775;4099.9180016399505;4136.6483848872585;4146.502419709594;4150.64719498846;4201.705880588391;3166.366726654632;3224.0327901629416;3227.8224697641854;3228.0315905228335;3238.141892398516;550.4495504495504;551.3053552523849;551.740681879524;554.8977155059272;572.1075122808433;462.4104267059526;550.2928736573564;562.6174201542908;567.3815541060181;595.553334998751;7244.311790379906;7424.220456852061;8222.547759873145;8333.083540661237;8774.780630484162;501.25563538146554;568.9260396148475;569.6866723302168;571.5142129190239;589.3723184808166;3646.507721457622;3656.725745569093;3748.4377343398164;3770.1517158639085;3819.2361527694015;56449.71775141098;57191.99140150457;57613;57697.4230257692;57700.71149644225;47400.7629961848;51949.22076168861;52593.211101833505;52609;52807;45331;45493;46438.5356146441;46774.53225467702;46845.06309873783;7786.454948153575;7995.400344974267;8098.109207986999;8135.633896474555;8196.877046844422;34138.82930585331;34189.82905085458;34441.48337774986;34906.12734681653;34983;43698.563014370724;44755.776221118685;44954;46418.53581464142;46756.06487870291;9696.854547181656;9715.805683886425;9996.150327222267;10011.54948027326;10154.796904062025;10453.895461045293;10593.735156621146;10992.505337260003;11488.080953523866;11636.825447618123;9392.483413412328;9558.378705384128;9729.4648794317;9888.802223955625;10191.439470828878;10160.568309694969;10395.920815836711;10513.369197848153;10521.894781052091;10602.681919542427;9732.270079743907;9754.170895473964;9873.703788886345;10136.746581335525;10152.187824974131;8832.38173327861;8944.910550894669;9060.139286767746;9229.815403692022;9391.248700104112;8699.695510657097;8830.646774128963;9077.773055673397;9183.403078799856;9200.171984521425 00:57:15 INFO - 2015-11-25 00:57:15,597 DEBUG : BROWSER_OUTPUT: __end_tp_report 00:57:15 INFO - 2015-11-25 00:57:15,597 DEBUG : BROWSER_OUTPUT: __start_cc_report 00:57:15 INFO - 2015-11-25 00:57:15,597 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,913 00:57:15 INFO - 2015-11-25 00:57:15,597 DEBUG : BROWSER_OUTPUT: __end_cc_report 00:57:15 INFO - 2015-11-25 00:57:15,597 DEBUG : BROWSER_OUTPUT: __startTimestamp1448441835583__endTimestamp 00:57:15 INFO - 2015-11-25 00:57:15,597 DEBUG : BROWSER_OUTPUT: 00:57:15 INFO - 2015-11-25 00:57:15,597 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 00:57:15 INFO - 2015-11-25 00:57:15,597 DEBUG : BROWSER_OUTPUT: Number of tests: 6 00:57:15 INFO - 2015-11-25 00:57:15,598 DEBUG : BROWSER_OUTPUT: 00:57:15 INFO - 2015-11-25 00:57:15,598 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:5428.85 Median:5622.35 stddev:608.20 (10.8%) stddev-sans-first:584.28 00:57:15 INFO - 2015-11-25 00:57:15,598 DEBUG : BROWSER_OUTPUT: Values: 3195.3 3258.7 3284.2 3290.7 3311.1 5239.9 5371.0 5412.7 5431.9 5437.3 5414.2 5427.3 5484.7 5492.8 5514.6 4841.7 4852.2 4860.4 4871.1 4953.7 4795.0 5043.2 5054.2 5055.3 5114.1 4789.9 4918.8 4928.9 4929.2 4946.8 4965.3 4978.0 4980.2 4987.4 5015.8 4752.1 4954.5 4962.6 4965.1 5024.3 5126.5 5150.2 5254.1 5279.2 5281.9 5831.4 5839.0 5846.4 5846.9 5848.7 5738.6 5872.6 5886.0 5887.4 5888.3 5434.2 5444.2 5490.4 5628.2 5628.7 6003.9 6050.0 6051.4 6070.8 6080.8 5715.5 5822.5 5823.7 5824.4 5864.6 5699.9 5818.2 5818.8 5906.1 5923.4 5949.1 5953.5 5955.7 5956.5 5986.7 5927.5 5940.6 5941.3 5943.3 5944.3 4326.6 4413.4 4451.1 4557.8 4560.4 4021.7 4048.4 4053.3 4054.7 4096.1 5585.8 5585.9 5586.7 5587.4 5615.1 5748.4 5807.7 5868.1 5870.9 5983.2 5543.0 5581.5 5584.0 5596.4 5598.8 5110.5 5113.2 5140.2 5144.3 5189.6 5856.2 5943.6 5949.3 6083.7 6089.1 5712.3 5773.6 5801.9 5809.2 5822.4 6029.5 6035.4 6041.9 6044.0 6061.9 5681.0 5744.7 5757.6 5778.3 5781.5 5770.4 5773.1 5864.1 5901.4 5909.3 5704.1 5793.4 5798.0 5798.6 5802.4 5377.4 5656.3 5666.4 5673.9 5674.6 5440.9 5479.6 5558.6 5566.9 5611.7 5696.5 5699.5 5713.5 5742.1 5793.3 5409.6 5531.3 5599.5 5622.4 5628.8 00:57:15 INFO - 2015-11-25 00:57:15,598 DEBUG : BROWSER_OUTPUT: 00:57:15 INFO - 2015-11-25 00:57:15,598 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:48702.60 Median:33265.58 stddev:85548.13 (257.2%) stddev-sans-first:85711.75 00:57:15 INFO - 2015-11-25 00:57:15,599 DEBUG : BROWSER_OUTPUT: Values: 561.4 596.9 609.2 613.0 615.1 31052.0 40389.0 41029.8 41052.6 41058.8 43294.8 43499.3 43629.0 43775.8 43932.0 7529.1 7649.9 8604.3 8856.4 8894.2 10185.5 10359.9 10390.8 10396.2 10405.6 10175.0 10281.9 10285.7 10288.0 10294.6 7741.5 7922.4 7923.0 7927.0 10129.9 10405.4 10686.9 10689.9 10693.7 10699.8 40186.0 40473.0 40521.8 40570.0 40595.0 3128.0 3206.9 3349.5 3351.7 3631.3 30298.7 30739.2 30795.7 30895.2 31668.0 3586.5 3597.8 3612.6 3659.6 3747.7 263837.0 265840.0 266222.7 266281.0 266367.0 58589.0 59549.1 60120.4 65915.0 66773.3 61661.4 61902.7 62003.7 62079.0 62239.0 15981.8 16138.4 16156.4 16161.7 16172.8 12403.4 12426.2 12449.4 12451.5 12533.8 20325.4 20462.8 20631.9 20683.1 20792.8 7987.9 8134.1 8247.8 8248.7 8264.4 938.6 979.5 1039.6 1056.9 1101.4 27900.4 28305.3 28619.6 32032.5 33136.5 985.9 1019.4 1049.3 1083.9 1119.5 14800.4 15016.5 15087.1 15243.2 15280.9 396745.0 403871.0 404325.0 405123.0 405253.0 53363.7 54108.2 54136.5 54157.7 54268.0 1340.8 1348.6 1354.8 1369.3 1376.4 27270.2 28337.6 28393.9 28408.6 28472.4 45137.8 45545.1 45749.0 45749.6 45793.8 289582.0 291380.0 291512.0 291784.0 291978.0 27201.9 30362.7 30658.8 30795.4 31038.2 36864.6 38109.4 38237.6 38239.6 38282.0 33394.7 33838.2 34589.5 34671.8 35017.0 34042.7 34306.0 34506.8 34700.0 35015.6 33536.3 34511.3 34617.8 34777.3 34877.0 28347.7 29875.4 31312.5 31492.0 31560.0 24251.1 24310.9 24371.6 24373.6 24576.4 00:57:15 INFO - 2015-11-25 00:57:15,599 DEBUG : BROWSER_OUTPUT: 00:57:15 INFO - 2015-11-25 00:57:15,599 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:25746.90 Median:18077.91 stddev:73723.73 (407.8%) stddev-sans-first:73905.88 00:57:15 INFO - 2015-11-25 00:57:15,599 DEBUG : BROWSER_OUTPUT: Values: 349.8 352.8 354.2 356.3 357.8 16115.2 16378.5 17002.2 17144.5 17152.3 17261.2 17416.1 17420.4 17467.0 17656.2 5216.5 5236.5 5331.2 5370.9 5373.6 5258.5 5319.8 5328.5 5330.7 5335.0 3915.3 3934.5 4369.0 5292.6 5298.1 5764.2 5765.0 5786.3 5790.9 5805.3 4861.3 5108.7 5110.8 5111.5 5112.9 10871.8 11154.8 11220.7 11225.9 12478.0 1698.8 1859.4 1885.5 1984.8 2191.4 9286.8 9475.0 9533.3 9835.0 12474.1 1788.6 1849.9 1863.7 1873.3 1883.9 42784.9 51121.0 56506.7 58509.7 59468.7 9885.0 10263.9 10292.4 10317.0 10362.1 13273.2 13333.2 13344.9 13345.7 13346.2 7050.4 7134.4 7385.4 7442.2 7488.5 7024.2 7025.1 7057.6 7064.2 7072.0 4318.2 4385.8 4420.9 4433.9 4451.4 1763.4 1782.9 1826.9 1828.8 1843.3 901.1 915.2 942.4 1060.8 1063.1 16161.0 16807.7 16885.7 17139.1 17206.8 889.7 931.1 993.7 995.0 995.3 9042.7 9303.9 9836.5 9887.9 9899.5 420668.0 423615.0 461167.0 472069.0 472129.0 74545.6 77472.6 78111.0 78872.2 79451.6 1097.1 1118.7 1126.2 1137.4 1154.6 12009.9 13442.2 14600.3 15003.8 15390.2 34841.7 35413.5 35421.1 35588.6 35798.0 44560.8 44895.8 45077.9 45871.3 47784.8 9192.9 9272.1 9305.3 9322.9 9355.5 13240.3 16492.3 16883.4 16910.3 17064.7 13495.9 13540.9 14063.4 14231.4 14469.8 13432.9 13697.4 13698.9 13852.9 13965.6 14370.9 14377.7 14627.0 14699.3 14961.0 8873.9 8906.4 9038.3 9164.4 9164.9 13990.7 14150.9 14157.3 14231.2 14644.7 00:57:15 INFO - 2015-11-25 00:57:15,600 DEBUG : BROWSER_OUTPUT: 00:57:15 INFO - 2015-11-25 00:57:15,600 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5071.12 Median:5947.51 stddev:2581.28 (43.4%) stddev-sans-first:2573.54 00:57:15 INFO - 2015-11-25 00:57:15,600 DEBUG : BROWSER_OUTPUT: Values: 1370.7 1639.9 1696.2 1714.2 1725.1 6424.0 7093.9 7220.5 7227.4 7244.8 7057.8 7251.1 7261.9 7263.3 7266.2 1893.9 1929.4 1934.4 2215.7 2255.0 2193.2 2242.2 2242.8 2245.2 2248.0 2125.4 2161.9 2232.2 2237.1 2237.4 1906.7 1959.5 2159.2 2216.3 2228.4 2177.2 2212.8 2216.8 2219.6 2220.1 7097.8 7174.8 7177.2 7177.3 7183.9 4405.2 4458.6 4476.5 4488.2 4517.4 2998.1 3034.4 3096.2 3097.2 3105.8 1028.9 1038.0 1043.0 1070.0 1083.6 9737.5 9739.9 9766.6 9771.7 9772.2 4055.6 4122.5 4184.5 4198.5 4209.2 8516.3 8516.3 8532.4 8535.7 8537.4 4583.0 4598.9 4602.2 4608.5 4609.9 4142.6 4170.6 4174.0 4180.2 4181.6 3493.7 3560.1 3567.2 3567.3 3570.4 1111.8 1127.9 1157.6 1171.9 1172.6 1009.9 1028.3 1030.4 1121.5 1261.2 6101.9 6251.1 6517.6 6631.9 6651.3 586.4 597.2 603.8 641.9 645.0 5038.4 5068.5 5088.5 5132.4 5135.2 8204.5 8618.9 8642.3 8647.9 8655.9 8455.0 8470.7 8572.4 8573.7 8575.8 6777.8 6791.8 6844.9 6863.6 6883.5 6520.4 6571.1 6575.0 6580.2 6590.6 7763.8 7793.8 7957.7 7958.4 7973.0 7970.2 8079.5 8202.5 8215.5 8224.9 6288.7 6392.7 6545.9 6606.7 6620.4 6827.7 6873.4 6882.8 6884.4 6897.6 6644.5 6668.5 6686.4 6770.7 6780.1 6384.0 6551.2 6568.4 6604.8 6627.6 5633.4 5688.3 6366.0 6408.1 6410.6 5731.5 5828.2 5856.2 5857.4 5858.6 5899.5 5941.4 5946.0 5949.0 5955.9 00:57:15 INFO - 2015-11-25 00:57:15,600 DEBUG : BROWSER_OUTPUT: 00:57:15 INFO - 2015-11-25 00:57:15,600 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:5277.07 Median:6010.37 stddev:1588.96 (26.4%) stddev-sans-first:1549.40 00:57:15 INFO - 2015-11-25 00:57:15,601 DEBUG : BROWSER_OUTPUT: Values: 328.4 332.4 332.9 334.9 337.3 5823.3 5960.4 5989.2 5996.9 6014.1 5752.1 5881.2 5893.4 5903.1 5905.7 4593.5 4605.3 4608.2 4612.9 4619.4 4419.1 4527.8 4527.8 4528.0 4607.9 4466.4 4565.8 4568.8 4570.1 4575.0 4555.8 4555.9 4565.4 4565.5 4576.2 4011.1 4012.9 4019.1 4019.9 4025.6 5478.8 5606.2 5608.6 5634.4 5649.1 5258.8 5262.2 5269.8 5270.8 5276.0 6006.6 6295.0 6297.9 6302.4 6309.6 4267.3 4287.8 4318.8 4326.0 4332.2 6377.8 6474.1 6492.3 6516.2 6518.9 4414.5 4451.4 4470.7 4474.8 4475.8 4450.1 4505.0 4530.8 4544.6 4549.6 5216.8 5222.7 5224.5 5231.1 5242.3 6246.8 6282.2 6319.1 6319.3 6323.2 1586.7 1598.2 1606.0 1610.9 1610.9 1060.3 1061.1 1066.5 1072.5 1073.2 6168.1 6174.8 6179.5 6181.3 6183.7 6513.7 6534.0 6542.1 6548.3 6551.9 5979.4 6104.8 6151.5 6155.6 6169.3 3498.6 3527.0 3527.4 3528.6 3530.3 6685.6 6687.4 6695.2 6695.3 6708.5 6661.0 6665.1 6667.6 6673.0 6676.6 6538.2 6657.4 6700.3 6706.1 6709.2 6379.3 6498.3 6500.5 6508.7 6509.6 6372.6 6488.7 6503.5 6519.4 6525.6 6787.7 6787.9 6788.7 6789.1 6791.6 4400.5 4452.8 4473.2 4475.0 4481.8 6502.5 6512.2 6512.2 6519.1 6531.2 6306.9 6308.4 6366.5 6369.3 6369.5 6096.7 6221.7 6222.4 6225.3 6228.6 6249.0 6251.7 6254.3 6255.9 6260.0 6373.7 6385.3 6394.6 6396.2 6407.7 6095.5 6231.3 6238.3 6250.2 6257.8 00:57:15 INFO - 2015-11-25 00:57:15,601 DEBUG : BROWSER_OUTPUT: 00:57:15 INFO - 2015-11-25 00:57:15,601 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:13318.94 Median:553.32 stddev:15867.95 (2867.8%) stddev-sans-first:15884.31 00:57:15 INFO - 2015-11-25 00:57:15,601 DEBUG : BROWSER_OUTPUT: Values: 732.2 807.9 828.9 829.1 840.2 13034.3 13357.9 13359.4 13379.6 13416.2 13107.1 13207.5 13209.7 13238.5 13261.5 675.5 683.8 816.6 822.4 835.5 822.7 826.0 828.8 830.3 834.3 703.3 865.5 865.7 870.2 870.8 706.0 844.0 849.3 851.0 851.1 636.0 636.2 636.5 638.7 639.2 13061.5 13064.6 13132.7 13165.9 13166.9 11164.8 11783.7 11844.6 11890.2 11997.5 9280.4 9298.8 9301.0 9358.1 9435.5 3417.3 3466.7 3471.2 3482.9 3490.1 43758.0 44703.6 45250.3 46432.3 46482.8 8475.1 8635.2 8648.7 8655.7 8691.8 16485.0 16503.3 16545.5 16548.7 16550.2 7317.2 7335.0 7341.3 7363.3 7439.4 4099.9 4136.6 4146.5 4150.6 4201.7 3166.4 3224.0 3227.8 3228.0 3238.1 550.4 551.3 551.7 554.9 572.1 462.4 550.3 562.6 567.4 595.6 7244.3 7424.2 8222.5 8333.1 8774.8 501.3 568.9 569.7 571.5 589.4 3646.5 3656.7 3748.4 3770.2 3819.2 56449.7 57192.0 57613.0 57697.4 57700.7 47400.8 51949.2 52593.2 52609.0 52807.0 45331.0 45493.0 46438.5 46774.5 46845.1 7786.5 7995.4 8098.1 8135.6 8196.9 34138.8 34189.8 34441.5 34906.1 34983.0 43698.6 44755.8 44954.0 46418.5 46756.1 9696.9 9715.8 9996.2 10011.5 10154.8 10453.9 10593.7 10992.5 11488.1 11636.8 9392.5 9558.4 9729.5 9888.8 10191.4 10160.6 10395.9 10513.4 10521.9 10602.7 9732.3 9754.2 9873.7 10136.7 10152.2 8832.4 8944.9 9060.1 9229.8 9391.2 8699.7 8830.6 9077.8 9183.4 9200.2 00:57:15 INFO - 2015-11-25 00:57:15,601 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 00:57:15 INFO - 2015-11-25 00:57:15,601 DEBUG : BROWSER_OUTPUT: 00:57:16 INFO - 2015-11-25 00:57:16,194 INFO : Browser exited with error code: 0 00:57:16 INFO - 2015-11-25 00:57:16,215 INFO : Completed test dromaeo_css (00:18:33) 00:57:16 INFO - 2015-11-25 00:57:16,215 INFO : Starting test kraken 00:57:16 INFO - 2015-11-25 00:57:16,215 DEBUG : operating with platform_type : linux_ 00:57:16 INFO - 2015-11-25 00:57:16,215 INFO : Initialising browser for kraken test... 00:57:16 INFO - 2015-11-25 00:57:16,221 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpH10ATq/profile http://localhost:48777/getInfo.html 00:57:20 INFO - 2015-11-25 00:57:20,041 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 00:57:20 INFO - 2015-11-25 00:57:20,043 DEBUG : BROWSER_OUTPUT: colorDepth:24 00:57:20 INFO - 2015-11-25 00:57:20,043 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 00:57:20 INFO - 2015-11-25 00:57:20,043 DEBUG : BROWSER_OUTPUT: __metrics 00:57:20 INFO - 2015-11-25 00:57:20,184 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 00:57:21 INFO - 2015-11-25 00:57:21,440 INFO : Browser initialized. 00:57:21 INFO - 2015-11-25 00:57:21,440 INFO : Running cycle 1/1 for kraken test... 00:57:21 INFO - 2015-11-25 00:57:21,440 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpH10ATq/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 00:57:33 INFO - 2015-11-25 00:57:33,163 DEBUG : BROWSER_OUTPUT: RSS: Main: 141447168 00:57:33 INFO - 2015-11-25 00:57:33,164 DEBUG : BROWSER_OUTPUT: 00:57:35 INFO - 2015-11-25 00:57:35,630 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:48777/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:48777/tests/kraken/driver.html?testName=audio-beat-detection) 00:57:36 INFO - 2015-11-25 00:57:36,213 DEBUG : BROWSER_OUTPUT: RSS: Main: 177729536 00:57:36 INFO - 2015-11-25 00:57:36,213 DEBUG : BROWSER_OUTPUT: 00:57:38 INFO - 2015-11-25 00:57:38,814 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:48777/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:48777/tests/kraken/driver.html?testName=audio-dft) 00:57:39 INFO - 2015-11-25 00:57:39,383 DEBUG : BROWSER_OUTPUT: RSS: Main: 166264832 00:57:39 INFO - 2015-11-25 00:57:39,383 DEBUG : BROWSER_OUTPUT: 00:57:42 INFO - 2015-11-25 00:57:42,310 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:48777/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:48777/tests/kraken/driver.html?testName=audio-fft) 00:57:42 INFO - 2015-11-25 00:57:42,876 DEBUG : BROWSER_OUTPUT: RSS: Main: 151040000 00:57:42 INFO - 2015-11-25 00:57:42,877 DEBUG : BROWSER_OUTPUT: 00:57:44 INFO - 2015-11-25 00:57:44,875 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:48777/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:48777/tests/kraken/driver.html?testName=audio-oscillator) 00:57:45 INFO - 2015-11-25 00:57:45,442 DEBUG : BROWSER_OUTPUT: RSS: Main: 153767936 00:57:45 INFO - 2015-11-25 00:57:45,443 DEBUG : BROWSER_OUTPUT: 00:57:47 INFO - 2015-11-25 00:57:47,657 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:48777/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:48777/tests/kraken/driver.html?testName=imaging-gaussian-blur) 00:57:48 INFO - 2015-11-25 00:57:48,218 DEBUG : BROWSER_OUTPUT: RSS: Main: 153522176 00:57:48 INFO - 2015-11-25 00:57:48,218 DEBUG : BROWSER_OUTPUT: 00:57:51 INFO - 2015-11-25 00:57:51,117 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:48777/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:48777/tests/kraken/driver.html?testName=imaging-darkroom) 00:57:51 INFO - 2015-11-25 00:57:51,685 DEBUG : BROWSER_OUTPUT: RSS: Main: 154087424 00:57:51 INFO - 2015-11-25 00:57:51,686 DEBUG : BROWSER_OUTPUT: 00:57:55 INFO - 2015-11-25 00:57:55,059 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:48777/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:48777/tests/kraken/driver.html?testName=imaging-desaturate) 00:57:55 INFO - 2015-11-25 00:57:55,628 DEBUG : BROWSER_OUTPUT: RSS: Main: 155246592 00:57:55 INFO - 2015-11-25 00:57:55,628 DEBUG : BROWSER_OUTPUT: 00:57:58 INFO - 2015-11-25 00:57:58,347 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:48777/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:48777/tests/kraken/driver.html?testName=json-parse-financial) 00:57:58 INFO - 2015-11-25 00:57:58,928 DEBUG : BROWSER_OUTPUT: RSS: Main: 154726400 00:57:58 INFO - 2015-11-25 00:57:58,928 DEBUG : BROWSER_OUTPUT: 00:58:00 INFO - 2015-11-25 00:58:00,468 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:48777/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:48777/tests/kraken/driver.html?testName=json-stringify-tinderbox) 00:58:01 INFO - 2015-11-25 00:58:01,029 DEBUG : BROWSER_OUTPUT: RSS: Main: 164134912 00:58:01 INFO - 2015-11-25 00:58:01,029 DEBUG : BROWSER_OUTPUT: 00:58:02 INFO - 2015-11-25 00:58:02,859 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:48777/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:48777/tests/kraken/driver.html?testName=stanford-crypto-aes) 00:58:03 INFO - 2015-11-25 00:58:03,452 DEBUG : BROWSER_OUTPUT: RSS: Main: 163381248 00:58:03 INFO - 2015-11-25 00:58:03,453 DEBUG : BROWSER_OUTPUT: 00:58:05 INFO - 2015-11-25 00:58:05,509 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:48777/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:48777/tests/kraken/driver.html?testName=stanford-crypto-ccm) 00:58:06 INFO - 2015-11-25 00:58:06,082 DEBUG : BROWSER_OUTPUT: RSS: Main: 168542208 00:58:06 INFO - 2015-11-25 00:58:06,082 DEBUG : BROWSER_OUTPUT: 00:58:08 INFO - 2015-11-25 00:58:08,531 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:48777/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:48777/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 00:58:09 INFO - 2015-11-25 00:58:09,112 DEBUG : BROWSER_OUTPUT: RSS: Main: 176357376 00:58:09 INFO - 2015-11-25 00:58:09,112 DEBUG : BROWSER_OUTPUT: 00:58:11 INFO - 2015-11-25 00:58:11,626 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:48777/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:48777/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 00:58:12 INFO - 2015-11-25 00:58:12,192 DEBUG : BROWSER_OUTPUT: RSS: Main: 176717824 00:58:12 INFO - 2015-11-25 00:58:12,192 DEBUG : BROWSER_OUTPUT: 00:58:13 INFO - 2015-11-25 00:58:13,845 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:48777/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:48777/tests/kraken/driver.html?testName=ai-astar) 00:58:14 INFO - 2015-11-25 00:58:14,103 DEBUG : BROWSER_OUTPUT: RSS: Main: 236802048 00:58:14 INFO - 2015-11-25 00:58:14,103 DEBUG : BROWSER_OUTPUT: 00:58:14 INFO - 2015-11-25 00:58:14,103 DEBUG : BROWSER_OUTPUT: __start_tp_report 00:58:14 INFO - 2015-11-25 00:58:14,104 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 00:58:14 INFO - 2015-11-25 00:58:14,104 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 00:58:14 INFO - 2015-11-25 00:58:14,104 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 00:58:14 INFO - 2015-11-25 00:58:14,104 DEBUG : BROWSER_OUTPUT: |0;ai-astar;109;115;103;109;112;111;99;112;109;103 00:58:14 INFO - 2015-11-25 00:58:14,104 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;150;124;149;162;126;157;151;123;171;123 00:58:14 INFO - 2015-11-25 00:58:14,104 DEBUG : BROWSER_OUTPUT: |2;audio-dft;161;161;160;163;160;160;160;164;160;161 00:58:14 INFO - 2015-11-25 00:58:14,104 DEBUG : BROWSER_OUTPUT: |3;audio-fft;72;70;79;90;71;71;71;130;96;74 00:58:14 INFO - 2015-11-25 00:58:14,104 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;93;93;149;93;92;93;143;93;93;138 00:58:14 INFO - 2015-11-25 00:58:14,104 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;109;110;109;110;110;110;111;110;110;109 00:58:14 INFO - 2015-11-25 00:58:14,104 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;145;146;144;145;145;146;145;146;145;145 00:58:14 INFO - 2015-11-25 00:58:14,105 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;96;95;96;96;96;95;96;96;95;95 00:58:14 INFO - 2015-11-25 00:58:14,105 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;59;58;57;57;57;58;57;65;55;56 00:58:14 INFO - 2015-11-25 00:58:14,105 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;69;70;69;69;70;70;72;70;70;70 00:58:14 INFO - 2015-11-25 00:58:14,105 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;83;85;85;84;84;93;84;91;85;84 00:58:14 INFO - 2015-11-25 00:58:14,105 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;117;129;123;117;121;119;125;125;124;133 00:58:14 INFO - 2015-11-25 00:58:14,105 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;136;150;148;137;148;138;149;149;148;143 00:58:14 INFO - 2015-11-25 00:58:14,105 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;68;67;67;67;67;65;65;65;65;66 00:58:14 INFO - 2015-11-25 00:58:14,106 DEBUG : BROWSER_OUTPUT: __end_tp_report 00:58:14 INFO - 2015-11-25 00:58:14,106 DEBUG : BROWSER_OUTPUT: __start_cc_report 00:58:14 INFO - 2015-11-25 00:58:14,106 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,909 00:58:14 INFO - 2015-11-25 00:58:14,106 DEBUG : BROWSER_OUTPUT: __end_cc_report 00:58:14 INFO - 2015-11-25 00:58:14,106 DEBUG : BROWSER_OUTPUT: __startTimestamp1448441894098__endTimestamp 00:58:14 INFO - 2015-11-25 00:58:14,106 DEBUG : BROWSER_OUTPUT: 00:58:14 INFO - 2015-11-25 00:58:14,107 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 00:58:14 INFO - 2015-11-25 00:58:14,107 DEBUG : BROWSER_OUTPUT: Number of tests: 14 00:58:14 INFO - 2015-11-25 00:58:14,107 DEBUG : BROWSER_OUTPUT: 00:58:14 INFO - 2015-11-25 00:58:14,107 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:108.20 Median:111.50 stddev:4.98 (4.5%) stddev-sans-first:5.28 00:58:14 INFO - 2015-11-25 00:58:14,107 DEBUG : BROWSER_OUTPUT: Values: 109.0 115.0 103.0 109.0 112.0 111.0 99.0 112.0 109.0 103.0 00:58:14 INFO - 2015-11-25 00:58:14,108 DEBUG : BROWSER_OUTPUT: 00:58:14 INFO - 2015-11-25 00:58:14,108 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:143.60 Median:150.50 stddev:18.06 (12.0%) stddev-sans-first:19.01 00:58:14 INFO - 2015-11-25 00:58:14,108 DEBUG : BROWSER_OUTPUT: Values: 150.0 124.0 149.0 162.0 126.0 157.0 151.0 123.0 171.0 123.0 00:58:14 INFO - 2015-11-25 00:58:14,108 DEBUG : BROWSER_OUTPUT: 00:58:14 INFO - 2015-11-25 00:58:14,108 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:161.00 Median:161.00 stddev:1.41 (0.9%) stddev-sans-first:1.50 00:58:14 INFO - 2015-11-25 00:58:14,109 DEBUG : BROWSER_OUTPUT: Values: 161.0 161.0 160.0 163.0 160.0 160.0 160.0 164.0 160.0 161.0 00:58:14 INFO - 2015-11-25 00:58:14,109 DEBUG : BROWSER_OUTPUT: 00:58:14 INFO - 2015-11-25 00:58:14,109 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:82.40 Median:73.00 stddev:18.98 (26.0%) stddev-sans-first:19.76 00:58:14 INFO - 2015-11-25 00:58:14,109 DEBUG : BROWSER_OUTPUT: Values: 72.0 70.0 79.0 90.0 71.0 71.0 71.0 130.0 96.0 74.0 00:58:14 INFO - 2015-11-25 00:58:14,109 DEBUG : BROWSER_OUTPUT: 00:58:14 INFO - 2015-11-25 00:58:14,109 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:108.00 Median:93.00 stddev:24.52 (26.4%) stddev-sans-first:25.40 00:58:14 INFO - 2015-11-25 00:58:14,109 DEBUG : BROWSER_OUTPUT: Values: 93.0 93.0 149.0 93.0 92.0 93.0 143.0 93.0 93.0 138.0 00:58:14 INFO - 2015-11-25 00:58:14,109 DEBUG : BROWSER_OUTPUT: 00:58:14 INFO - 2015-11-25 00:58:14,109 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:109.80 Median:110.00 stddev:0.63 (0.6%) stddev-sans-first:0.60 00:58:14 INFO - 2015-11-25 00:58:14,110 DEBUG : BROWSER_OUTPUT: Values: 109.0 110.0 109.0 110.0 110.0 110.0 111.0 110.0 110.0 109.0 00:58:14 INFO - 2015-11-25 00:58:14,110 DEBUG : BROWSER_OUTPUT: 00:58:14 INFO - 2015-11-25 00:58:14,110 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:145.20 Median:145.00 stddev:0.63 (0.4%) stddev-sans-first:0.67 00:58:14 INFO - 2015-11-25 00:58:14,110 DEBUG : BROWSER_OUTPUT: Values: 145.0 146.0 144.0 145.0 145.0 146.0 145.0 146.0 145.0 145.0 00:58:14 INFO - 2015-11-25 00:58:14,110 DEBUG : BROWSER_OUTPUT: 00:58:14 INFO - 2015-11-25 00:58:14,111 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:95.60 Median:96.00 stddev:0.52 (0.5%) stddev-sans-first:0.53 00:58:14 INFO - 2015-11-25 00:58:14,111 DEBUG : BROWSER_OUTPUT: Values: 96.0 95.0 96.0 96.0 96.0 95.0 96.0 96.0 95.0 95.0 00:58:14 INFO - 2015-11-25 00:58:14,111 DEBUG : BROWSER_OUTPUT: 00:58:14 INFO - 2015-11-25 00:58:14,111 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:57.90 Median:57.50 stddev:2.73 (4.7%) stddev-sans-first:2.86 00:58:14 INFO - 2015-11-25 00:58:14,111 DEBUG : BROWSER_OUTPUT: Values: 59.0 58.0 57.0 57.0 57.0 58.0 57.0 65.0 55.0 56.0 00:58:14 INFO - 2015-11-25 00:58:14,111 DEBUG : BROWSER_OUTPUT: 00:58:14 INFO - 2015-11-25 00:58:14,111 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:69.90 Median:70.00 stddev:0.88 (1.3%) stddev-sans-first:0.87 00:58:14 INFO - 2015-11-25 00:58:14,112 DEBUG : BROWSER_OUTPUT: Values: 69.0 70.0 69.0 69.0 70.0 70.0 72.0 70.0 70.0 70.0 00:58:14 INFO - 2015-11-25 00:58:14,112 DEBUG : BROWSER_OUTPUT: 00:58:14 INFO - 2015-11-25 00:58:14,112 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:85.80 Median:85.00 stddev:3.36 (4.0%) stddev-sans-first:3.41 00:58:14 INFO - 2015-11-25 00:58:14,112 DEBUG : BROWSER_OUTPUT: Values: 83.0 85.0 85.0 84.0 84.0 93.0 84.0 91.0 85.0 84.0 00:58:14 INFO - 2015-11-25 00:58:14,112 DEBUG : BROWSER_OUTPUT: 00:58:14 INFO - 2015-11-25 00:58:14,112 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:123.30 Median:124.50 stddev:5.12 (4.1%) stddev-sans-first:4.90 00:58:14 INFO - 2015-11-25 00:58:14,112 DEBUG : BROWSER_OUTPUT: Values: 117.0 129.0 123.0 117.0 121.0 119.0 125.0 125.0 124.0 133.0 00:58:14 INFO - 2015-11-25 00:58:14,112 DEBUG : BROWSER_OUTPUT: 00:58:14 INFO - 2015-11-25 00:58:14,112 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:144.60 Median:148.00 stddev:5.58 (3.8%) stddev-sans-first:4.98 00:58:14 INFO - 2015-11-25 00:58:14,112 DEBUG : BROWSER_OUTPUT: Values: 136.0 150.0 148.0 137.0 148.0 138.0 149.0 149.0 148.0 143.0 00:58:14 INFO - 2015-11-25 00:58:14,112 DEBUG : BROWSER_OUTPUT: 00:58:14 INFO - 2015-11-25 00:58:14,112 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.20 Median:67.00 stddev:1.14 (1.7%) stddev-sans-first:1.00 00:58:14 INFO - 2015-11-25 00:58:14,112 DEBUG : BROWSER_OUTPUT: Values: 68.0 67.0 67.0 67.0 67.0 65.0 65.0 65.0 65.0 66.0 00:58:14 INFO - 2015-11-25 00:58:14,112 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 00:58:14 INFO - 2015-11-25 00:58:14,112 DEBUG : BROWSER_OUTPUT: 00:58:14 INFO - 2015-11-25 00:58:14,949 INFO : Browser exited with error code: 0 00:58:15 INFO - 2015-11-25 00:58:15,000 INFO : Completed test kraken (00:00:58) 00:58:15 INFO - 2015-11-25 00:58:15,000 INFO : Starting test v8_7 00:58:15 INFO - 2015-11-25 00:58:15,000 DEBUG : operating with platform_type : linux_ 00:58:15 INFO - 2015-11-25 00:58:15,001 INFO : Initialising browser for v8_7 test... 00:58:15 INFO - 2015-11-25 00:58:15,007 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpDuGhlm/profile http://localhost:48777/getInfo.html 00:58:18 INFO - 2015-11-25 00:58:18,899 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 00:58:18 INFO - 2015-11-25 00:58:18,899 DEBUG : BROWSER_OUTPUT: colorDepth:24 00:58:18 INFO - 2015-11-25 00:58:18,899 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 00:58:18 INFO - 2015-11-25 00:58:18,899 DEBUG : BROWSER_OUTPUT: __metrics 00:58:19 INFO - 2015-11-25 00:58:19,056 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 00:58:20 INFO - 2015-11-25 00:58:20,176 INFO : Browser initialized. 00:58:20 INFO - 2015-11-25 00:58:20,176 INFO : Running cycle 1/1 for v8_7 test... 00:58:20 INFO - 2015-11-25 00:58:20,177 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpDuGhlm/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 00:58:31 INFO - 2015-11-25 00:58:31,857 DEBUG : BROWSER_OUTPUT: RSS: Main: 138952704 00:58:31 INFO - 2015-11-25 00:58:31,857 DEBUG : BROWSER_OUTPUT: 00:58:53 INFO - 2015-11-25 00:58:53,291 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:48777/tests/v8_7/run.html (next: http://localhost:48777/tests/v8_7/run.html) 00:58:53 INFO - 2015-11-25 00:58:53,549 DEBUG : BROWSER_OUTPUT: RSS: Main: 164302848 00:58:53 INFO - 2015-11-25 00:58:53,549 DEBUG : BROWSER_OUTPUT: 00:58:53 INFO - 2015-11-25 00:58:53,549 DEBUG : BROWSER_OUTPUT: __start_tp_report 00:58:53 INFO - 2015-11-25 00:58:53,549 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 00:58:53 INFO - 2015-11-25 00:58:53,549 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 00:58:53 INFO - 2015-11-25 00:58:53,549 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 00:58:53 INFO - 2015-11-25 00:58:53,550 DEBUG : BROWSER_OUTPUT: |0;Richards;164.5548790521639 00:58:53 INFO - 2015-11-25 00:58:53,550 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;188.67924528301887 00:58:53 INFO - 2015-11-25 00:58:53,550 DEBUG : BROWSER_OUTPUT: |2;Encrypt;279.9552071668533 00:58:53 INFO - 2015-11-25 00:58:53,550 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5175.257731958763 00:58:53 INFO - 2015-11-25 00:58:53,550 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1101.3215859030836 00:58:53 INFO - 2015-11-25 00:58:53,550 DEBUG : BROWSER_OUTPUT: |5;Earley;784.3137254901961 00:58:53 INFO - 2015-11-25 00:58:53,550 DEBUG : BROWSER_OUTPUT: |6;Boyer;12537.5 00:58:53 INFO - 2015-11-25 00:58:53,550 DEBUG : BROWSER_OUTPUT: |7;RegExp;26736.842105263157 00:58:53 INFO - 2015-11-25 00:58:53,551 DEBUG : BROWSER_OUTPUT: |8;Splay;554.9389567147614 00:58:53 INFO - 2015-11-25 00:58:53,551 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4830.917874396136 00:58:53 INFO - 2015-11-25 00:58:53,551 DEBUG : BROWSER_OUTPUT: __end_tp_report 00:58:53 INFO - 2015-11-25 00:58:53,551 DEBUG : BROWSER_OUTPUT: __startTimestamp1448441933542__endTimestamp 00:58:53 INFO - 2015-11-25 00:58:53,551 DEBUG : BROWSER_OUTPUT: 00:58:53 INFO - 2015-11-25 00:58:53,551 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 00:58:53 INFO - 2015-11-25 00:58:53,551 DEBUG : BROWSER_OUTPUT: Number of tests: 10 00:58:53 INFO - 2015-11-25 00:58:53,551 DEBUG : BROWSER_OUTPUT: 00:58:53 INFO - 2015-11-25 00:58:53,551 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:164.55 Median:164.55 stddev:0.00 (0.0%) 00:58:53 INFO - 2015-11-25 00:58:53,551 DEBUG : BROWSER_OUTPUT: Values: 164.6 00:58:53 INFO - 2015-11-25 00:58:53,551 DEBUG : BROWSER_OUTPUT: 00:58:53 INFO - 2015-11-25 00:58:53,551 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:188.68 Median:188.68 stddev:0.00 (0.0%) 00:58:53 INFO - 2015-11-25 00:58:53,551 DEBUG : BROWSER_OUTPUT: Values: 188.7 00:58:53 INFO - 2015-11-25 00:58:53,551 DEBUG : BROWSER_OUTPUT: 00:58:53 INFO - 2015-11-25 00:58:53,552 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:279.96 Median:279.96 stddev:0.00 (0.0%) 00:58:53 INFO - 2015-11-25 00:58:53,552 DEBUG : BROWSER_OUTPUT: Values: 280.0 00:58:53 INFO - 2015-11-25 00:58:53,552 DEBUG : BROWSER_OUTPUT: 00:58:53 INFO - 2015-11-25 00:58:53,552 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5175.26 Median:5175.26 stddev:0.00 (0.0%) 00:58:53 INFO - 2015-11-25 00:58:53,552 DEBUG : BROWSER_OUTPUT: Values: 5175.3 00:58:53 INFO - 2015-11-25 00:58:53,552 DEBUG : BROWSER_OUTPUT: 00:58:53 INFO - 2015-11-25 00:58:53,552 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1101.32 Median:1101.32 stddev:0.00 (0.0%) 00:58:53 INFO - 2015-11-25 00:58:53,552 DEBUG : BROWSER_OUTPUT: Values: 1101.3 00:58:53 INFO - 2015-11-25 00:58:53,552 DEBUG : BROWSER_OUTPUT: 00:58:53 INFO - 2015-11-25 00:58:53,552 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:784.31 Median:784.31 stddev:0.00 (0.0%) 00:58:53 INFO - 2015-11-25 00:58:53,552 DEBUG : BROWSER_OUTPUT: Values: 784.3 00:58:53 INFO - 2015-11-25 00:58:53,552 DEBUG : BROWSER_OUTPUT: 00:58:53 INFO - 2015-11-25 00:58:53,552 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:12537.50 Median:12537.50 stddev:0.00 (0.0%) 00:58:53 INFO - 2015-11-25 00:58:53,552 DEBUG : BROWSER_OUTPUT: Values: 12537.5 00:58:53 INFO - 2015-11-25 00:58:53,552 DEBUG : BROWSER_OUTPUT: 00:58:53 INFO - 2015-11-25 00:58:53,552 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:26736.84 Median:26736.84 stddev:0.00 (0.0%) 00:58:53 INFO - 2015-11-25 00:58:53,553 DEBUG : BROWSER_OUTPUT: Values: 26736.8 00:58:53 INFO - 2015-11-25 00:58:53,553 DEBUG : BROWSER_OUTPUT: 00:58:53 INFO - 2015-11-25 00:58:53,553 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:554.94 Median:554.94 stddev:0.00 (0.0%) 00:58:53 INFO - 2015-11-25 00:58:53,553 DEBUG : BROWSER_OUTPUT: Values: 554.9 00:58:53 INFO - 2015-11-25 00:58:53,553 DEBUG : BROWSER_OUTPUT: 00:58:53 INFO - 2015-11-25 00:58:53,553 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4830.92 Median:4830.92 stddev:0.00 (0.0%) 00:58:53 INFO - 2015-11-25 00:58:53,553 DEBUG : BROWSER_OUTPUT: Values: 4830.9 00:58:53 INFO - 2015-11-25 00:58:53,553 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 00:58:53 INFO - 2015-11-25 00:58:53,553 DEBUG : BROWSER_OUTPUT: 00:58:54 INFO - 2015-11-25 00:58:54,365 INFO : Browser exited with error code: 0 00:58:54 INFO - 2015-11-25 00:58:54,382 INFO : Completed test v8_7 (00:00:39) 00:58:54 INFO - 2015-11-25 00:58:54,508 INFO : Completed test suite (00:20:11) 00:58:54 INFO - 2015-11-25 00:58:54,508 DEBUG : Working with test: dromaeo_css 00:58:54 INFO - 2015-11-25 00:58:54,509 DEBUG : Generating results file: dromaeo_css 00:58:54 INFO - 2015-11-25 00:58:54,510 DEBUG : Working with test: kraken 00:58:54 INFO - 2015-11-25 00:58:54,510 DEBUG : Generating results file: kraken 00:58:54 INFO - 2015-11-25 00:58:54,510 INFO : javascript benchmark 00:58:54 INFO - 2015-11-25 00:58:54,510 DEBUG : Working with test: v8_7 00:58:54 INFO - 2015-11-25 00:58:54,510 DEBUG : Generating results file: v8_7 00:58:54 INFO - 2015-11-25 00:58:54,511 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 00:58:54 INFO - 2015-11-25 00:58:54,572 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,63,35]] 00:58:54 INFO - 2015-11-25 00:58:54,572 DEBUG : process_Request line: dromaeo_css 6847.88 graph.html#tests=[[72,63,35]] 00:58:54 INFO - 2015-11-25 00:58:54,572 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 00:58:54 INFO - 2015-11-25 00:58:54,615 DEBUG : process_Request line: kraken 1501.50 graph.html#tests=[[232,63,35]] 00:58:54 INFO - 2015-11-25 00:58:54,615 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 00:58:54 INFO - 2015-11-25 00:58:54,657 DEBUG : process_Request line: v8_7 21144.67 graph.html#tests=[[230,63,35]] 00:58:54 INFO - 2015-11-25 00:58:54,659 INFO : javascript benchmark 00:58:54 INFO - 2015-11-25 00:58:54,662 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3195.281061761104, 3258.67413258674, 3284.178955261185, 3290.670932906711, 3311.122552523581, 5239.895202095956, 5370.973145134279, 5412.702301373423, 5431.918521222185, 5437.293151890253, 5414.187871819219, 5427.294451721271, 5484.725763711808, 5492.835214943558, 5514.641548299358, 4841.685290456118, 4852.2479015752615, 4860.416749989989, 4871.050145221683, 4953.702777833323, 4795.040991801636, 5043.193089105744, 5054.21659642756, 5055.31753213317, 5114.079465696173, 4789.880252993686, 4918.803247870081, 4928.852134435972, 4929.211326187793, 4946.802127914879, 4965.255211718235, 4978.00439912019, 4980.228064649985, 4987.426445958725, 5015.824446144404, 4752.07334569759, 4954.529319714621, 4962.578180854632, 4965.131102057126, 5024.346834911475, 5126.512981266774, 5150.227465880111, 5254.054270231357, 5279.234510995884, 5281.947180528184, 5831.358550559435, 5839.0, 5846.356900740915, 5846.853828654318, 5848.736806843703, 5738.598298119134, 5872.559558033122, 5885.970570147165, 5887.411258874121, 5888.263967004124, 5434.184872269152, 5444.237806707064, 5490.396056433789, 5628.240187574707, 5628.71856407178, 6003.909941350883, 6050.031994880798, 6051.394860514001, 6070.817875463743, 6080.75676972925, 5715.457031581993, 5822.534197264294, 5823.679697616587, 5824.446677565625, 5864.560157988168, 5699.886002279931, 5818.156367326798, 5818.796342128006, 5906.084556893688, 5923.437273459014, 5949.137375080676, 5953.464188223081, 5955.672438015864, 5956.463918247378, 5986.73059712314, 5927.466528012414, 5940.61386009908, 5941.257342832146, 5943.3462319144855, 5944.256967879015, 4326.63223625989, 4413.426254586883, 4451.132029254329, 4557.840475583405, 4560.3843481129625, 4021.738586991895, 4048.4129801178665, 4053.250148722496, 4054.716169868081, 4096.05790668148, 5585.776568937197, 5585.944140558624, 5586.748596313176, 5587.38538760736, 5615.129654903497, 5748.425157484218, 5807.68057756819, 5868.119782032729, 5870.911936320958, 5983.1623572699855, 5543.029969755276, 5581.49766521015, 5584.0, 5596.412376700469, 5598.832035038955, 5110.514501122388, 5113.181890897438, 5140.203268493389, 5144.331236939174, 5189.6107791915, 5856.209411729447, 5943.554233432596, 5949.315828679671, 6083.665398403042, 6089.117078023662, 5712.285964254468, 5773.566982476415, 5801.883962320646, 5809.157672137601, 5822.388649191943, 6029.51763858899, 6035.39646035393, 6041.909371359346, 6043.969780151247, 6061.909071364022, 5680.971595142163, 5744.741486633028, 5757.568182386254, 5778.306603207642, 5781.4507621775865, 5770.365259821332, 5773.1051686988585, 5864.06175011996, 5901.380355062828, 5909.261342332208, 5704.1443783432815, 5793.420657934173, 5798.043322851851, 5798.623089499169, 5802.4197580241635, 5377.3816011159215, 5656.264685590847, 5666.433356664301, 5673.858153546194, 5674.602777805679, 5440.863978400572, 5479.6164268500825, 5558.583106266965, 5566.944330556643, 5611.719414029364, 5696.487316141567, 5699.5155411790465, 5713.542916566582, 5742.08126699726, 5793.304803423616, 5409.648372855751, 5531.2532808072, 5599.496045355938, 5622.353429355513, 5628.774849005994], "unit": "ms", "name": "dojo.html", "value": 5389.277742914878}, {"lowerIsBetter": false, "replicates": [561.3572459533834, 596.9253843269591, 609.1776102261946, 613.0, 615.0651010464092, 31052.0, 40389.0, 41029.79485102578, 41052.58947410533, 41058.79470602646, 43294.78352608233, 43499.34750978738, 43629.0, 43775.78112109443, 43932.0, 7529.058867641545, 7649.923500765005, 8604.26863716585, 8856.424332418372, 8894.199522043014, 10185.541650625739, 10359.948200258988, 10390.844137337946, 10396.168306535497, 10405.583776648926, 10175.0, 10281.948590257038, 10285.691429257135, 10288.0, 10294.588216471333, 7741.5355078695175, 7922.405819563556, 7922.960385198095, 7926.960365198195, 10129.89870101297, 10405.427701476416, 10686.893131068668, 10689.893101069045, 10693.679189624323, 10699.78600427995, 40186.0, 40473.0, 40521.79739101315, 40570.0, 40595.0, 3127.9530807037913, 3206.8556914938886, 3349.531065650811, 3351.731861451078, 3631.346357655621, 30298.69701303003, 30739.231519211975, 30795.692043079507, 30895.227619309473, 31668.0, 3586.497890295361, 3597.784132952031, 3612.638736126393, 3659.597444281127, 3747.681447077002, 263837.0, 265840.0, 266222.6688866563, 266281.0, 266367.0, 58589.0, 59549.129306594936, 60120.398796012356, 65915.0, 66773.3322666767, 61661.38338616646, 61902.69048654728, 62003.689981550706, 62079.0, 62239.0, 15981.760273595906, 16138.354465821236, 16156.434524791575, 16161.676766464605, 16172.75740863888, 12403.379831008413, 12426.192297500633, 12449.377531123408, 12451.501939922482, 12533.811992820116, 20325.390238292875, 20462.79537204609, 20631.896840515703, 20683.06926188325, 20792.792072079086, 7987.880181797278, 8134.145914678874, 8247.793805154919, 8248.731598810255, 8264.380171487162, 938.5729493080632, 979.5298256836616, 1039.5633833789827, 1056.8784589772274, 1101.4107452512867, 27900.441991160063, 28305.292367690974, 28619.57070643942, 32032.519512207335, 33136.50295245573, 985.8866230383454, 1019.4189312092036, 1049.2969710294121, 1083.8807731149568, 1119.4626579241847, 14800.407983680747, 15016.47442339513, 15087.094774313577, 15243.23783810805, 15280.923595381952, 396745.0, 403871.0, 404325.0, 405123.0, 405253.0, 53363.733181334625, 54108.188377174374, 54136.45863541393, 54157.72921135369, 54268.0, 1340.825692659948, 1348.5549768576345, 1354.837419509665, 1369.274284629148, 1376.4081444978556, 27270.181894543195, 28337.574936375557, 28393.858030709715, 28408.57387139153, 28472.430551389272, 45137.77431112823, 45545.089098217184, 45749.0, 45749.595056691425, 45793.77103114463, 289582.0, 291380.0, 291512.0, 291784.0, 291978.0, 27201.86399067992, 30362.696373035986, 30658.84670576633, 30795.38409231758, 31038.22404439907, 36864.63135368612, 38109.4283585752, 38237.617623823404, 38239.61760382361, 38282.0, 33394.666053339155, 33838.154046149044, 34589.48115778316, 34671.82664086663, 35017.0, 34042.65957340395, 34306.0, 34506.82746586251, 34700.0, 35015.64984350124, 33536.329273414885, 34511.30977380388, 34617.82691086629, 34777.30445391129, 34877.0, 28347.716522834507, 29875.402491949604, 31312.530312045794, 31492.0, 31560.0, 24251.052797218545, 24310.878445607657, 24371.634425483986, 24373.63439548373, 24576.385590360384], "unit": "ms", "name": "ext.html", "value": 18826.982482103827}, {"lowerIsBetter": false, "replicates": [349.77789103919, 352.75131032622005, 354.24015486780854, 356.3265428340437, 357.81930125286726, 16115.194240287983, 16378.508644740647, 17002.234899429524, 17144.485665430027, 17152.313907443717, 17261.223244953977, 17416.129193540335, 17420.39028633998, 17467.0, 17656.205470753815, 5216.478352164791, 5236.450172731856, 5331.173668081454, 5370.91943620846, 5373.596980226479, 5258.526732594066, 5319.760610772524, 5328.5470734987575, 5330.733463326837, 5335.013022590813, 3915.3343931531567, 3934.4688467057013, 4368.97815510922, 5292.629515933886, 5298.0993231150605, 5764.221830052952, 5765.019946609086, 5786.334571524287, 5790.913136302959, 5805.274340707411, 4861.343718597979, 5108.7445627718835, 5110.8466745997675, 5111.539961403454, 5112.926285480054, 10871.782564348669, 11154.832677509843, 11220.66338009861, 11225.887741122566, 12478.0, 1698.8046374666949, 1859.3771086685977, 1885.4909174522938, 1984.8015198480182, 2191.375457994464, 9286.814263714688, 9475.0, 9533.332666713333, 9834.9508252459, 12474.126811123226, 1788.5618023584175, 1849.9352522661643, 1863.6738570750065, 1873.3443294846832, 1883.8775479593783, 42784.93037674052, 51121.0, 56506.71746641282, 58509.7074514629, 59468.70265648644, 9885.0, 10263.897361026295, 10292.382457052601, 10317.0, 10362.119219866245, 13273.203607783564, 13333.20000799955, 13344.866551334362, 13345.73308533824, 13346.199228046155, 7050.4007159391, 7134.429245660334, 7385.4460915431555, 7442.18136005039, 7488.51324663906, 7024.192217894905, 7025.121859767529, 7057.576545407292, 7064.152301723723, 7072.0, 4318.222719910384, 4385.780710964439, 4420.9336859947125, 4433.911321773547, 4451.354553589711, 1763.3916298876868, 1782.910854457298, 1826.9269229230947, 1828.772217036931, 1843.2811203630595, 901.1304091551684, 915.1946287267162, 942.4392486470539, 1060.8355704865758, 1063.1016790811752, 16161.0, 16807.747883781754, 16885.746713799304, 17139.14304284781, 17206.827931720774, 889.7419748273057, 931.0596297739332, 993.7118235711707, 994.9900500994897, 995.2585323933571, 9042.728718138467, 9303.906960930439, 9836.508174591241, 9887.851682224773, 9899.455529945923, 420668.0, 423615.0, 461167.0, 472069.0, 472129.0, 74545.6272718633, 77472.61263693645, 78111.00136681518, 78872.21127788763, 79451.60274198592, 1097.0948967102172, 1118.7426891814928, 1126.2060247525476, 1137.38581166171, 1154.5785788187252, 12009.939950300542, 13442.193468391928, 14600.342984565508, 15003.77494337564, 15390.153541554873, 34841.65158348384, 35413.46879796754, 35421.11447213737, 35588.644113558534, 35798.0, 44560.77719611511, 44895.77552112219, 45077.873053173935, 45871.31193032041, 47784.761076194394, 9192.908070919206, 9272.119148680864, 9305.255579553756, 9322.860157097784, 9355.549889767097, 13240.337983100999, 16492.34030638761, 16883.40908068261, 16910.32358705687, 17064.744028839825, 13495.865041349462, 13540.864591354355, 14063.367148478139, 14231.430742770173, 14469.782953255499, 13432.865671343552, 13697.383617737027, 13698.931505342409, 13852.93073534626, 13965.58103256904, 14370.928145359207, 14377.712445751236, 14627.0, 14699.338529765972, 14961.0, 8873.890763654543, 8906.376553641183, 9038.322125840457, 9164.358494905293, 9164.862527061967, 13990.650233744238, 14150.858491414954, 14157.292135392983, 14231.217283049531, 14644.707105858037], "unit": "ms", "name": "jquery.html", "value": 8548.84640158997}, {"lowerIsBetter": false, "replicates": [1370.7327071221116, 1639.8934069285497, 1696.2027846911947, 1714.2457318779736, 1725.1288099509745, 6424.0, 7093.929060709392, 7220.530665506738, 7227.385672217854, 7244.7826565202995, 7057.823554411142, 7251.057362542862, 7261.854762904752, 7263.309985551364, 7266.237045110267, 1893.8768980016323, 1929.372953790017, 1934.4003358958769, 2215.7230346206725, 2254.977450225493, 2193.21044424008, 2242.192810588187, 2242.7869352411576, 2245.247841972941, 2247.9996401601293, 2125.4048866317457, 2161.945951351213, 2232.151782322723, 2237.0604346174646, 2237.44063984004, 1906.6663333916579, 1959.519917620185, 2159.222679835258, 2216.3350994701605, 2228.4094714900402, 2177.150911144655, 2212.8340374471977, 2216.789405006522, 2219.622664147099, 2220.0675716199235, 7097.751578694721, 7174.820629484252, 7177.210506844243, 7177.318154775288, 7183.928160718378, 4405.207062728708, 4458.643308535309, 4476.529964353761, 4488.214562451558, 4517.412736344254, 2998.055612482061, 3034.408290383376, 3096.210466331094, 3097.1947293703574, 3105.844707764603, 1028.8713910761155, 1037.9532921018572, 1042.9530671119742, 1069.9893001069968, 1083.6153165626247, 9737.513124343754, 9739.90260097397, 9766.609335626566, 9771.706848794547, 9772.16936560386, 4055.614716601918, 4122.505299364096, 4184.539700632928, 4198.517170525429, 4209.221294060609, 8516.27611653004, 8516.318694504425, 8532.36007299455, 8535.701250456204, 8537.359698022674, 4582.977085114553, 4598.8620341389815, 4602.240630296031, 4608.539146085432, 4609.9308510372375, 4142.606452387018, 4170.624643782075, 4174.0, 4180.163967206571, 4181.6236538711055, 3493.703035242033, 3560.0565850049757, 3567.1973805893986, 3567.3222087803233, 3570.4465807799834, 1111.8054340490382, 1127.8984891359653, 1157.6179860645966, 1171.9003884669728, 1172.6013155526991, 1009.9040591143829, 1028.3264461777549, 1030.443560477334, 1121.472907733364, 1261.211742660837, 6101.938980610226, 6251.093591429218, 6517.608943463408, 6631.900521492182, 6651.301613330531, 586.3608666553478, 597.235538510707, 603.8399824046631, 641.913341698874, 644.9613023218621, 5038.395392552917, 5068.543831055223, 5088.5420312171345, 5132.435432102466, 5135.152699804565, 8204.466709663971, 8618.870716939251, 8642.265407440438, 8647.913520864711, 8655.870161947576, 8454.957725211334, 8470.661173553111, 8572.3999320047, 8573.699920502877, 8575.828483430421, 6777.796666099926, 6791.796246112525, 6844.93155068443, 6863.622500762506, 6883.483738719616, 6520.380563846427, 6571.080048793077, 6574.967125164344, 6580.177477815273, 6590.637514936724, 7763.805904852424, 7793.766187014398, 7957.721479748181, 7958.363330933627, 7973.043234811859, 7970.242826931432, 8079.474834135763, 8202.466839655403, 8215.548144852091, 8224.917750822655, 6288.654124023223, 6392.680365981775, 6545.934540654723, 6606.702698378488, 6620.437262832713, 6827.658617069226, 6873.381395674413, 6882.7591034313555, 6884.449244060564, 6897.62063086515, 6644.501662375438, 6668.466522678271, 6686.364795344434, 6770.661466926733, 6780.084688566981, 6383.96808015957, 6551.21385433751, 6568.441682457044, 6604.8348791280605, 6627.635480048643, 5633.436656334334, 5688.288963879515, 6366.013267943476, 6408.07082972957, 6410.551261411656, 5731.512821410227, 5828.213191219301, 5856.209411729362, 5857.4435428634215, 5858.619189752652, 5899.528037757055, 5941.376155503783, 5945.970270148621, 5949.0481522956115, 5955.91066134017], "unit": "ms", "name": "mootools.html", "value": 4167.1268831808175}, {"lowerIsBetter": false, "replicates": [328.41705971899887, 332.4149496885481, 332.86851693581036, 334.9380364632543, 337.31861639488227, 5823.330317013545, 5960.4337587929185, 5989.161517387563, 5996.8800623987545, 6014.127951447043, 5752.108423194401, 5881.176635271066, 5893.38119497453, 5903.114532820079, 5905.734241959111, 4593.517680643535, 4605.332226827108, 4608.21660317746, 4612.884677883063, 4619.422572178478, 4419.138268037734, 4527.750973696446, 4527.818887244523, 4528.0, 4607.884802879938, 4466.3747075409465, 4565.840195593155, 4568.7944042518, 4570.10882877839, 4574.99350142968, 4555.772211389451, 4555.886102847422, 4565.383673204141, 4565.497795242521, 4576.1762882681105, 4011.0774521859844, 4012.879613611567, 4019.095703466726, 4019.8593049243136, 4025.577314381977, 5478.780848766045, 5606.243157173811, 5608.6073974821775, 5634.408387119375, 5649.124385720179, 5258.8159414420315, 5262.158244614393, 5269.815556455505, 5270.7628156733035, 5276.0, 6006.609570377911, 6294.968525157391, 6297.905531417033, 6302.401271879165, 6309.589876658002, 4267.271754939224, 4287.785610719483, 4318.762468064255, 4325.956740432587, 4332.241857674926, 6377.808665740035, 6474.093626892239, 6492.285848556702, 6516.152900122954, 6518.902216466757, 4414.536473670282, 4451.3545535897765, 4470.687051906335, 4474.753888536096, 4475.753833539186, 4450.087732014929, 4504.977475112669, 4530.77346132692, 4544.636429085665, 4549.613282870927, 5216.817411390583, 5222.738863056832, 5224.52979231871, 5231.0584094862525, 5242.344706911636, 6246.843828904313, 6282.246130464374, 6319.05214217871, 6319.304876463585, 6323.241211054611, 1586.698527279813, 1598.20888660114, 1606.03637817311, 1610.8952918060522, 1610.927508262131, 1060.347886050089, 1061.0874647802884, 1066.4827558634056, 1072.5280876414354, 1073.2272763610188, 6168.136460895478, 6174.845628859314, 6179.5056395488255, 6181.258249010058, 6183.74293382912, 6513.739450422025, 6534.0, 6542.051402546699, 6548.345165483509, 6551.934480655133, 5979.355677188721, 6104.847378815565, 6151.477124444383, 6155.599886007395, 6169.259688837368, 3498.6151523332414, 3527.0, 3527.4179760339257, 3528.647135286451, 3530.293941211768, 6685.598864068074, 6687.431568316748, 6695.163104611924, 6695.330466953265, 6708.530402871752, 6661.0, 6665.066890635315, 6667.63328016954, 6673.03241030048, 6676.566023208476, 6538.1500404947055, 6657.434118100015, 6700.329967003261, 6706.094677218611, 6709.19489661234, 6379.266384365857, 6498.252700939453, 6500.5449618526245, 6508.739650413931, 6509.609423434609, 6372.6495042773095, 6488.70800813974, 6503.479721622164, 6519.445847103049, 6525.608463492205, 6787.694553745192, 6787.932120678927, 6788.744082344782, 6789.1174147360525, 6791.592504449749, 4400.493943196573, 4452.821887124479, 4473.172463094338, 4474.955250447584, 4481.7535035573355, 6502.544821862424, 6512.185976752906, 6512.218533775977, 6519.054737063005, 6531.216254049545, 6306.905396419149, 6308.400701933309, 6366.522510811615, 6369.331220221995, 6369.458596019205, 6096.65278867648, 6221.720022598904, 6222.377762223922, 6225.28409232944, 6228.564000520101, 6249.0, 6251.749930002749, 6254.311335939362, 6255.906161407492, 6259.968700156653, 6373.74505019794, 6385.265694445198, 6394.6482943436695, 6396.168498095218, 6407.711652975534, 6095.481884039907, 6231.314555398993, 6238.313785483684, 6250.1874756281395, 6257.78097766576], "unit": "ms", "name": "prototype.html", "value": 4759.574324828416}, {"lowerIsBetter": false, "replicates": [732.1909290234291, 807.8688005227386, 828.908820029797, 829.1128492513012, 840.2227939156282, 13034.348282585868, 13357.933210333947, 13359.398827052783, 13379.59861204163, 13416.195028298309, 13107.148035377693, 13207.471701131943, 13209.735805283888, 13238.53665121721, 13261.535846245384, 675.5338816216819, 683.8461346197091, 816.6406781016364, 822.3873214455239, 835.5237514616671, 822.6668199379261, 826.0417915218347, 828.8176601147737, 830.3191383065888, 834.3241974001079, 703.2721133626698, 865.5412631305387, 865.7056600755742, 870.2472361407368, 870.8214815962713, 706.015108923052, 844.0420123160227, 849.2950850793826, 851.0043249398188, 851.085083535196, 635.9554831161821, 636.1697984130708, 636.5162476517834, 638.6902352359149, 639.1563136659611, 13061.542846000439, 13064.608061758163, 13132.6716832079, 13165.86834131656, 13166.868331316757, 11164.832527512093, 11783.7054073648, 11844.644660660195, 11890.167688261825, 11997.46011429479, 9280.443173409618, 9298.814023719555, 9301.0, 9358.063890036283, 9435.528223588863, 3417.2652879631, 3466.687998080185, 3471.20162362658, 3482.8606855725993, 3490.057684425191, 43758.0, 44703.55296447026, 45250.321245181345, 46432.3035154473, 46482.76758616219, 8475.110113438124, 8635.179657932485, 8648.740537783877, 8655.740327790176, 8691.782705432415, 16485.0, 16503.257353418885, 16545.50363489097, 16548.669026619402, 16550.172491375382, 7317.158526769384, 7334.963325183447, 7341.265873412723, 7363.263673632594, 7439.442041846775, 4099.9180016399505, 4136.6483848872585, 4146.502419709594, 4150.64719498846, 4201.705880588391, 3166.366726654632, 3224.0327901629416, 3227.8224697641854, 3228.0315905228335, 3238.141892398516, 550.4495504495504, 551.3053552523849, 551.740681879524, 554.8977155059272, 572.1075122808433, 462.4104267059526, 550.2928736573564, 562.6174201542908, 567.3815541060181, 595.553334998751, 7244.311790379906, 7424.220456852061, 8222.547759873145, 8333.083540661237, 8774.780630484162, 501.25563538146554, 568.9260396148475, 569.6866723302168, 571.5142129190239, 589.3723184808166, 3646.507721457622, 3656.725745569093, 3748.4377343398164, 3770.1517158639085, 3819.2361527694015, 56449.71775141098, 57191.99140150457, 57613.0, 57697.4230257692, 57700.71149644225, 47400.7629961848, 51949.22076168861, 52593.211101833505, 52609.0, 52807.0, 45331.0, 45493.0, 46438.5356146441, 46774.53225467702, 46845.06309873783, 7786.454948153575, 7995.400344974267, 8098.109207986999, 8135.633896474555, 8196.877046844422, 34138.82930585331, 34189.82905085458, 34441.48337774986, 34906.12734681653, 34983.0, 43698.563014370724, 44755.776221118685, 44954.0, 46418.53581464142, 46756.06487870291, 9696.854547181656, 9715.805683886425, 9996.150327222267, 10011.54948027326, 10154.796904062025, 10453.895461045293, 10593.735156621146, 10992.505337260003, 11488.080953523866, 11636.825447618123, 9392.483413412328, 9558.378705384128, 9729.4648794317, 9888.802223955625, 10191.439470828878, 10160.568309694969, 10395.920815836711, 10513.369197848153, 10521.894781052091, 10602.681919542427, 9732.270079743907, 9754.170895473964, 9873.703788886345, 10136.746581335525, 10152.187824974131, 8832.38173327861, 8944.910550894669, 9060.139286767746, 9229.815403692022, 9391.248700104112, 8699.695510657097, 8830.646774128963, 9077.773055673397, 9183.403078799856, 9200.171984521425], "unit": "ms", "name": "yui.html", "value": 5993.367213248538}], "name": "dromaeo_css", "value": 6847.878751992532}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [109.0, 115.0, 103.0, 109.0, 112.0, 111.0, 99.0, 112.0, 109.0, 103.0], "unit": "ms", "name": "ai-astar", "value": 108.2}, {"lowerIsBetter": true, "replicates": [150.0, 124.0, 149.0, 162.0, 126.0, 157.0, 151.0, 123.0, 171.0, 123.0], "unit": "ms", "name": "audio-beat-detection", "value": 143.6}, {"lowerIsBetter": true, "replicates": [161.0, 161.0, 160.0, 163.0, 160.0, 160.0, 160.0, 164.0, 160.0, 161.0], "unit": "ms", "name": "audio-dft", "value": 161.0}, {"lowerIsBetter": true, "replicates": [72.0, 70.0, 79.0, 90.0, 71.0, 71.0, 71.0, 130.0, 96.0, 74.0], "unit": "ms", "name": "audio-fft", "value": 82.4}, {"lowerIsBetter": true, "replicates": [93.0, 93.0, 149.0, 93.0, 92.0, 93.0, 143.0, 93.0, 93.0, 138.0], "unit": "ms", "name": "audio-oscillator", "value": 108.0}, {"lowerIsBetter": true, "replicates": [109.0, 110.0, 109.0, 110.0, 110.0, 110.0, 111.0, 110.0, 110.0, 109.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 109.8}, {"lowerIsBetter": true, "replicates": [145.0, 146.0, 144.0, 145.0, 145.0, 146.0, 145.0, 146.0, 145.0, 145.0], "unit": "ms", "name": "imaging-darkroom", "value": 145.2}, {"lowerIsBetter": true, "replicates": [96.0, 95.0, 96.0, 96.0, 96.0, 95.0, 96.0, 96.0, 95.0, 95.0], "unit": "ms", "name": "imaging-desaturate", "value": 95.6}, {"lowerIsBetter": true, "replicates": [59.0, 58.0, 57.0, 57.0, 57.0, 58.0, 57.0, 65.0, 55.0, 56.0], "unit": "ms", "name": "json-parse-financial", "value": 57.9}, {"lowerIsBetter": true, "replicates": [69.0, 70.0, 69.0, 69.0, 70.0, 70.0, 72.0, 70.0, 70.0, 70.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 69.9}, {"lowerIsBetter": true, "replicates": [83.0, 85.0, 85.0, 84.0, 84.0, 93.0, 84.0, 91.0, 85.0, 84.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 85.8}, {"lowerIsBetter": true, "replicates": [117.0, 129.0, 123.0, 117.0, 121.0, 119.0, 125.0, 125.0, 124.0, 133.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 123.3}, {"lowerIsBetter": true, "replicates": [136.0, 150.0, 148.0, 137.0, 148.0, 138.0, 149.0, 149.0, 148.0, 143.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 144.6}, {"lowerIsBetter": true, "replicates": [68.0, 67.0, 67.0, 67.0, 67.0, 65.0, 65.0, 65.0, 65.0, 66.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 66.2}], "name": "kraken", "value": 1501.5}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [164.5548790521639], "unit": "score", "name": "Richards", "value": 214.53025399999996}, {"lowerIsBetter": false, "replicates": [188.67924528301887], "unit": "score", "name": "DeltaBlue", "value": 350.4253999999999}, {"lowerIsBetter": false, "replicates": [279.9552071668533], "unit": "score", "name": "Encrypt", "value": 950.7985320000004}, {"lowerIsBetter": false, "replicates": [5175.257731958763], "unit": "score", "name": "Decrypt", "value": 51.433380478087685}, {"lowerIsBetter": false, "replicates": [1101.3215859030836], "unit": "score", "name": "RayTrace", "value": 671.910012}, {"lowerIsBetter": false, "replicates": [784.3137254901961], "unit": "score", "name": "Earley", "value": 849.7403250000002}, {"lowerIsBetter": false, "replicates": [12537.5], "unit": "score", "name": "Boyer", "value": 53.15756729810566}, {"lowerIsBetter": false, "replicates": [26736.842105263157], "unit": "score", "name": "RegExp", "value": 34.07227362204725}, {"lowerIsBetter": false, "replicates": [554.9389567147614], "unit": "score", "name": "Splay", "value": 146.846782}, {"lowerIsBetter": false, "replicates": [4830.917874396136], "unit": "score", "name": "NavierStokes", "value": 307.1879999999999}], "name": "v8_7", "value": 21144.66540865389}]} 00:58:54 INFO - RETURN: dromaeo_css: 6847.88 00:58:54 INFO - RETURN: kraken: 1501.50 00:58:54 INFO - RETURN: v8_7: 21144.67 00:58:54 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,63,35]]", "result": "21144.67"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,63,35]]", "result": "1501.50"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,63,35]]", "result": "6847.88"}}} 00:58:54 INFO - Return code: 0 00:58:54 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 00:58:54 INFO - # TBPL SUCCESS # 00:58:54 INFO - Running post-action listener: _resource_record_post_action 00:58:54 INFO - Running post-run listener: _resource_record_post_run 00:58:55 INFO - Total resource usage - Wall time: 1226s; CPU: 13.0%; Read bytes: 4096; Write bytes: 499171328; Read time: 8; Write time: 381668 00:58:55 INFO - install - Wall time: 15s; CPU: 13.0%; Read bytes: 0; Write bytes: 223674368; Read time: 0; Write time: 196852 00:58:55 INFO - run-tests - Wall time: 1212s; CPU: 13.0%; Read bytes: 4096; Write bytes: 263327744; Read time: 8; Write time: 155196 00:58:55 INFO - Running post-run listener: _upload_blobber_files 00:58:55 INFO - Blob upload gear active. 00:58:55 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 00:58:55 INFO - Copying logs to upload dir... 00:58:55 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1269.084350 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 9 secs) (at 2015-11-25 00:58:55.240332) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-25 00:58:55.243503) ========= 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=e10134013339c31d8d0c4708000001d6-1448440368.874188-1470675506 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/px5GceqESrG3iOAqINa-1w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.010170 build_url: 'https://queue.taskcluster.net/v1/task/px5GceqESrG3iOAqINa-1w/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-25 00:58:55.295393) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-25 00:58:55.295736) ========= 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=e10134013339c31d8d0c4708000001d6-1448440368.874188-1470675506 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004556 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-25 00:58:55.346210) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-25 00:58:55.346656) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-25 00:58:55.347012) ========= ========= Total master_lag: 0.21 =========