builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-065 starttime: 1448458463.51 results: success (0) buildid: 20151125030231 builduid: 4e3686b132034f4c9b2008b10e0f7b4e revision: 099f695d31326c39595264c34988a0f4b7cbc698 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-11-25 05:34:23.508460) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-11-25 05:34:23.508866) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-25 05:34:23.509159) ========= 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=20aa3857bbc5a756c598c738000001bb-1448458142.577917-117337063 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.003774 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.04 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-25 05:34:23.555829) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-25 05:34:23.556522) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-25 05:34:23.597240) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-25 05:34:23.598212) ========= 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=20aa3857bbc5a756c598c738000001bb-1448458142.577917-117337063 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.041425 ========= master_lag: 0.01 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-25 05:34:23.650865) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-25 05:34:23.653361) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-25 05:34:23.653772) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-25 05:34:23.654057) ========= 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=20aa3857bbc5a756c598c738000001bb-1448458142.577917-117337063 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-11-25 05:34:23-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 46.7M=0s 2015-11-25 05:34:24 (46.7 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.428790 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-25 05:34:24.094832) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-25 05:34:24.095150) ========= 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=20aa3857bbc5a756c598c738000001bb-1448458142.577917-117337063 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.105100 ========= master_lag: 0.01 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-25 05:34:24.211427) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-25 05:34:24.211769) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 099f695d31326c39595264c34988a0f4b7cbc698 --destination scripts --debug' in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 099f695d31326c39595264c34988a0f4b7cbc698 --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=20aa3857bbc5a756c598c738000001bb-1448458142.577917-117337063 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-11-25 05:34:24,271 truncating revision to first 12 chars 2015-11-25 05:34:24,271 Setting DEBUG logging. 2015-11-25 05:34:24,271 attempt 1/10 2015-11-25 05:34:24,271 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/099f695d3132?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-11-25 05:34:24,630 unpacking tar archive at: mozilla-central-099f695d3132/testing/mozharness/ program finished with exit code 0 elapsedTime=0.654606 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-25 05:34:24.881787) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-25 05:34:24.885116) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-25 05:34:24.900503) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-25 05:34:24.900771) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-25 05:34:24.901160) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 17 secs) (at 2015-11-25 05:34:24.901438) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test-pgo/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--system-bits', '64', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test-pgo/buildprops.json PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=20aa3857bbc5a756c598c738000001bb-1448458142.577917-117337063 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 05:34:25 INFO - MultiFileLogger online at 20151125 05:34:25 in /builds/slave/test-pgo 05:34:25 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 05:34:25 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 05:34:25 INFO - {'append_to_log': False, 05:34:25 INFO - 'base_work_dir': '/builds/slave/test-pgo', 05:34:25 INFO - 'blob_upload_branch': 'Firefox', 05:34:25 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 05:34:25 INFO - 'branch': 'Firefox', 05:34:25 INFO - 'buildbot_json_path': 'buildprops.json', 05:34:25 INFO - 'config_files': ('talos/linux_config.py',), 05:34:25 INFO - 'default_actions': ('clobber', 05:34:25 INFO - 'read-buildbot-config', 05:34:25 INFO - 'download-and-extract', 05:34:25 INFO - 'populate-webroot', 05:34:25 INFO - 'create-virtualenv', 05:34:25 INFO - 'install', 05:34:25 INFO - 'run-tests'), 05:34:25 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:34:25 INFO - 'download_minidump_stackwalk': True, 05:34:25 INFO - 'download_symbols': 'ondemand', 05:34:25 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:34:25 INFO - 'tooltool.py': '/tools/tooltool.py', 05:34:25 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:34:25 INFO - '/tools/misc-python/virtualenv.py')}, 05:34:25 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:34:25 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:34:25 INFO - 'installer_path': 'installer.exe', 05:34:25 INFO - 'log_level': 'info', 05:34:25 INFO - 'log_name': 'talos', 05:34:25 INFO - 'log_to_console': True, 05:34:25 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 05:34:25 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 05:34:25 INFO - 'opt_config_files': (), 05:34:25 INFO - 'pip_index': False, 05:34:25 INFO - 'sps_profile': False, 05:34:25 INFO - 'sps_profile_interval': 0, 05:34:25 INFO - 'suite': 'dromaeojs-e10s', 05:34:25 INFO - 'system_bits': '64', 05:34:25 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:34:25 INFO - 'title': 'talos-linux64-ix-065', 05:34:25 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:34:25 INFO - 'use_talos_json': True, 05:34:25 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 05:34:25 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:34:25 INFO - 'work_dir': 'build'} 05:34:25 INFO - ##### 05:34:25 INFO - ##### Running clobber step. 05:34:25 INFO - ##### 05:34:25 INFO - Running pre-action listener: _resource_record_pre_action 05:34:25 INFO - Running main action method: clobber 05:34:25 INFO - rmtree: /builds/slave/test-pgo/build 05:34:25 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 05:34:26 INFO - Running post-action listener: _resource_record_post_action 05:34:26 INFO - ##### 05:34:26 INFO - ##### Running read-buildbot-config step. 05:34:26 INFO - ##### 05:34:26 INFO - Running pre-action listener: _resource_record_pre_action 05:34:26 INFO - Running main action method: read_buildbot_config 05:34:26 INFO - Using buildbot properties: 05:34:26 INFO - { 05:34:26 INFO - "properties": { 05:34:26 INFO - "buildnumber": 35, 05:34:26 INFO - "product": "firefox", 05:34:26 INFO - "script_repo_revision": "production", 05:34:26 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 05:34:26 INFO - "repository": "", 05:34:26 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs-e10s", 05:34:26 INFO - "buildid": "20151125030231", 05:34:26 INFO - "slavename": "talos-linux64-ix-065", 05:34:26 INFO - "stage_platform": "linux64-pgo", 05:34:26 INFO - "basedir": "/builds/slave/test-pgo", 05:34:26 INFO - "nightly_build": "True", 05:34:26 INFO - "project": "", 05:34:26 INFO - "platform": "ubuntu64_hw", 05:34:26 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 05:34:26 INFO - "slavebuilddir": "test", 05:34:26 INFO - "scheduler": "tests-mozilla-central-linux64-pgo-talos", 05:34:26 INFO - "branch": "mozilla-central", 05:34:26 INFO - "repo_path": "mozilla-central", 05:34:26 INFO - "pgo_build": "True", 05:34:26 INFO - "builduid": "4e3686b132034f4c9b2008b10e0f7b4e", 05:34:26 INFO - "revision": "099f695d31326c39595264c34988a0f4b7cbc698" 05:34:26 INFO - }, 05:34:26 INFO - "sourcestamp": { 05:34:26 INFO - "repository": "", 05:34:26 INFO - "hasPatch": false, 05:34:26 INFO - "project": "", 05:34:26 INFO - "branch": "mozilla-central-linux64-pgo-talos", 05:34:26 INFO - "changes": [ 05:34:26 INFO - { 05:34:26 INFO - "category": null, 05:34:26 INFO - "files": [ 05:34:26 INFO - { 05:34:26 INFO - "url": null, 05:34:26 INFO - "name": "https://queue.taskcluster.net/v1/task/K7V4RDtZQ_2QUQmqJz7NIg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2" 05:34:26 INFO - } 05:34:26 INFO - ], 05:34:26 INFO - "repository": "", 05:34:26 INFO - "rev": "099f695d31326c39595264c34988a0f4b7cbc698", 05:34:26 INFO - "who": "sendchange", 05:34:26 INFO - "when": 1448458301, 05:34:26 INFO - "number": 6705629, 05:34:26 INFO - "comments": "", 05:34:26 INFO - "project": "", 05:34:26 INFO - "at": "Wed 25 Nov 2015 05:31:41", 05:34:26 INFO - "branch": "mozilla-central-linux64-pgo-talos", 05:34:26 INFO - "revlink": "", 05:34:26 INFO - "properties": [ 05:34:26 INFO - [ 05:34:26 INFO - "buildid", 05:34:26 INFO - "20151125030231", 05:34:26 INFO - "Change" 05:34:26 INFO - ], 05:34:26 INFO - [ 05:34:26 INFO - "builduid", 05:34:26 INFO - "4e3686b132034f4c9b2008b10e0f7b4e", 05:34:26 INFO - "Change" 05:34:26 INFO - ], 05:34:26 INFO - [ 05:34:26 INFO - "nightly_build", 05:34:26 INFO - "True", 05:34:26 INFO - "Change" 05:34:26 INFO - ], 05:34:26 INFO - [ 05:34:26 INFO - "pgo_build", 05:34:26 INFO - "True", 05:34:26 INFO - "Change" 05:34:26 INFO - ] 05:34:26 INFO - ], 05:34:26 INFO - "revision": "099f695d31326c39595264c34988a0f4b7cbc698" 05:34:26 INFO - } 05:34:26 INFO - ], 05:34:26 INFO - "revision": "099f695d31326c39595264c34988a0f4b7cbc698" 05:34:26 INFO - } 05:34:26 INFO - } 05:34:26 INFO - Found installer url https://queue.taskcluster.net/v1/task/K7V4RDtZQ_2QUQmqJz7NIg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2. 05:34:26 INFO - Running post-action listener: _resource_record_post_action 05:34:26 INFO - ##### 05:34:26 INFO - ##### Running download-and-extract step. 05:34:26 INFO - ##### 05:34:26 INFO - Running pre-action listener: _resource_record_pre_action 05:34:26 INFO - Running main action method: download_and_extract 05:34:26 INFO - mkdir: /builds/slave/test-pgo/build/tests 05:34:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:34:26 INFO - https://queue.taskcluster.net/v1/task/K7V4RDtZQ_2QUQmqJz7NIg/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 05:34:26 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/K7V4RDtZQ_2QUQmqJz7NIg/artifacts/public/build/test_packages.json 05:34:26 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/K7V4RDtZQ_2QUQmqJz7NIg/artifacts/public/build/test_packages.json 05:34:26 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/K7V4RDtZQ_2QUQmqJz7NIg/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 05:34:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/K7V4RDtZQ_2QUQmqJz7NIg/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 05:34:26 INFO - Downloaded 1302 bytes. 05:34:26 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 05:34:26 INFO - Using the following test package requirements: 05:34:26 INFO - {u'common': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 05:34:26 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 05:34:26 INFO - u'firefox-45.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 05:34:26 INFO - u'jittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 05:34:26 INFO - u'jsshell-linux-x86_64.zip'], 05:34:26 INFO - u'mochitest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 05:34:26 INFO - u'firefox-45.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 05:34:26 INFO - u'mozbase': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 05:34:26 INFO - u'reftest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 05:34:26 INFO - u'firefox-45.0a1.en-US.linux-x86_64.reftest.tests.zip'], 05:34:26 INFO - u'talos': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 05:34:26 INFO - u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'], 05:34:26 INFO - u'web-platform': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 05:34:26 INFO - u'firefox-45.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 05:34:26 INFO - u'webapprt': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 05:34:26 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 05:34:26 INFO - u'firefox-45.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 05:34:26 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 05:34:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:34:26 INFO - https://queue.taskcluster.net/v1/task/K7V4RDtZQ_2QUQmqJz7NIg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:34:26 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/K7V4RDtZQ_2QUQmqJz7NIg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 05:34:26 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/K7V4RDtZQ_2QUQmqJz7NIg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 05:34:26 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/K7V4RDtZQ_2QUQmqJz7NIg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 05:34:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/K7V4RDtZQ_2QUQmqJz7NIg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 05:34:28 INFO - Downloaded 22530104 bytes. 05:34:28 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test-pgo/build/tests 05:34:28 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 05:34:28 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 05:34:29 INFO - Return code: 0 05:34:29 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 05:34:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:34:29 INFO - https://queue.taskcluster.net/v1/task/K7V4RDtZQ_2QUQmqJz7NIg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:34:29 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/K7V4RDtZQ_2QUQmqJz7NIg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 05:34:29 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/K7V4RDtZQ_2QUQmqJz7NIg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 05:34:29 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/K7V4RDtZQ_2QUQmqJz7NIg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 05:34:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/K7V4RDtZQ_2QUQmqJz7NIg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 05:34:43 INFO - Downloaded 22530104 bytes. 05:34:43 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test-pgo/build/tests 05:34:43 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 05:34:43 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 05:34:44 INFO - Return code: 0 05:34:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:34:44 INFO - https://queue.taskcluster.net/v1/task/K7V4RDtZQ_2QUQmqJz7NIg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 05:34:44 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/K7V4RDtZQ_2QUQmqJz7NIg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 05:34:44 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/K7V4RDtZQ_2QUQmqJz7NIg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 05:34:44 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/K7V4RDtZQ_2QUQmqJz7NIg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 05:34:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/K7V4RDtZQ_2QUQmqJz7NIg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 05:34:45 INFO - Downloaded 11131717 bytes. 05:34:45 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'] in /builds/slave/test-pgo/build/tests 05:34:45 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 05:34:45 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'] with output_timeout 1760 05:34:46 INFO - Return code: 0 05:34:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:34:46 INFO - https://queue.taskcluster.net/v1/task/K7V4RDtZQ_2QUQmqJz7NIg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 05:34:46 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/K7V4RDtZQ_2QUQmqJz7NIg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 05:34:46 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/K7V4RDtZQ_2QUQmqJz7NIg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 05:34:46 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/K7V4RDtZQ_2QUQmqJz7NIg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 05:34:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/K7V4RDtZQ_2QUQmqJz7NIg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 05:34:49 INFO - Downloaded 58392259 bytes. 05:34:49 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/K7V4RDtZQ_2QUQmqJz7NIg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 05:34:49 INFO - mkdir: /builds/slave/test-pgo/properties 05:34:49 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 05:34:49 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 05:34:49 INFO - Contents: 05:34:49 INFO - build_url:https://queue.taskcluster.net/v1/task/K7V4RDtZQ_2QUQmqJz7NIg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 05:34:49 INFO - Running post-action listener: _resource_record_post_action 05:34:49 INFO - Running post-action listener: set_extra_try_arguments 05:34:49 INFO - ##### 05:34:49 INFO - ##### Running populate-webroot step. 05:34:49 INFO - ##### 05:34:49 INFO - Running pre-action listener: _resource_record_pre_action 05:34:49 INFO - Running main action method: populate_webroot 05:34:49 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:34:49 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:34:49 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 05:34:49 INFO - '../fennec_ids.txt'], 05:34:49 INFO - 'tests': ['tcheck2']}, 05:34:49 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:34:49 INFO - '--tppagecycles', 05:34:49 INFO - '7'], 05:34:49 INFO - 'tests': ['tsvgm']}}, 05:34:49 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 05:34:49 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 05:34:49 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:34:49 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 05:34:49 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 05:34:49 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 05:34:49 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:34:49 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:34:49 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:34:49 INFO - 'talos_options': ['--e10s'], 05:34:49 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:34:49 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:34:49 INFO - 'tests': ['damp', 'tps']}, 05:34:49 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:34:49 INFO - 'talos_options': ['--e10s'], 05:34:49 INFO - 'tests': ['damp', 'tps']}, 05:34:49 INFO - 'g3': {'tests': ['dromaeo_dom']}, 05:34:49 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:34:49 INFO - 'other': {'tests': ['a11yr', 05:34:49 INFO - 'ts_paint', 05:34:49 INFO - 'tpaint', 05:34:49 INFO - 'sessionrestore', 05:34:49 INFO - 'sessionrestore_no_auto_restore']}, 05:34:49 INFO - 'other-e10s': {'talos_options': ['--e10s'], 05:34:49 INFO - 'tests': ['a11yr', 05:34:49 INFO - 'ts_paint', 05:34:49 INFO - 'tpaint', 05:34:49 INFO - 'sessionrestore', 05:34:49 INFO - 'sessionrestore_no_auto_restore']}, 05:34:49 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 05:34:49 INFO - 'tests': ['a11yr', 05:34:49 INFO - 'ts_paint', 05:34:49 INFO - 'tpaint', 05:34:49 INFO - 'sessionrestore', 05:34:49 INFO - 'sessionrestore_no_auto_restore']}, 05:34:49 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 05:34:49 INFO - 'tests': ['a11yr', 05:34:49 INFO - 'ts_paint', 05:34:49 INFO - 'tpaint', 05:34:49 INFO - 'sessionrestore', 05:34:49 INFO - 'sessionrestore_no_auto_restore']}, 05:34:49 INFO - 'other_l64': {'tests': ['a11yr', 05:34:49 INFO - 'ts_paint', 05:34:49 INFO - 'tpaint', 05:34:49 INFO - 'sessionrestore', 05:34:49 INFO - 'sessionrestore_no_auto_restore']}, 05:34:49 INFO - 'other_nol64': {'tests': ['a11yr', 05:34:49 INFO - 'ts_paint', 05:34:49 INFO - 'tpaint', 05:34:49 INFO - 'sessionrestore', 05:34:49 INFO - 'sessionrestore_no_auto_restore']}, 05:34:49 INFO - 'svgr': {'tests': ['tsvgx', 05:34:49 INFO - 'tsvgr_opacity', 05:34:49 INFO - 'tart', 05:34:49 INFO - 'tscrollx', 05:34:49 INFO - 'cart']}, 05:34:49 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 05:34:49 INFO - 'tests': ['tsvgx', 05:34:49 INFO - 'tsvgr_opacity', 05:34:49 INFO - 'tart', 05:34:49 INFO - 'tscrollx', 05:34:49 INFO - 'cart']}, 05:34:49 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:34:49 INFO - 'tests': ['tp5o']}, 05:34:49 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:34:49 INFO - 'talos_options': ['--e10s'], 05:34:49 INFO - 'tests': ['tp5o']}, 05:34:49 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:34:49 INFO - 'talos_options': ['--xperf_path', 05:34:49 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:34:49 INFO - 'tests': ['tp5n']}, 05:34:49 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:34:49 INFO - 'talos_options': ['--e10s', 05:34:49 INFO - '--xperf_path', 05:34:49 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:34:49 INFO - 'tests': ['tp5n']}}, 05:34:49 INFO - 'talos.zip': {'path': '', 05:34:49 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:34:49 INFO - Running post-action listener: _resource_record_post_action 05:34:49 INFO - ##### 05:34:49 INFO - ##### Running create-virtualenv step. 05:34:49 INFO - ##### 05:34:49 INFO - Running pre-action listener: _resource_record_pre_action 05:34:49 INFO - Running main action method: create_virtualenv 05:34:49 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 05:34:49 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test-pgo/build/venv'] in /builds/slave/test-pgo/build 05:34:49 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 05:34:49 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:34:49 INFO - Using real prefix '/usr' 05:34:49 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 05:34:49 INFO - Installing distribute.............................................................................................................................................................................................done. 05:34:51 INFO - Installing pip.................done. 05:34:51 INFO - Return code: 0 05:34:51 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 05:34:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:34:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:34:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:34:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:34:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:34:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:34:51 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 0x1c54030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1db48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e817d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f10640>, '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 0x1f11540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f119d0>, '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': '20aa3857bbc5a756c598c738000001bb-1448458142.577917-117337063', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:34:51 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test-pgo/build 05:34:51 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 05:34:51 INFO - Using env: {'DISPLAY': ':0', 05:34:51 INFO - 'HOME': '/home/cltbld', 05:34:51 INFO - 'LANG': 'en_US.UTF-8', 05:34:51 INFO - 'LANGUAGE': 'en_US:en', 05:34:51 INFO - 'LOGNAME': 'cltbld', 05:34:51 INFO - 'MAIL': '/var/mail/cltbld', 05:34:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:34:51 INFO - 'MOZ_NO_REMOTE': '1', 05:34:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:34:51 INFO - 'NO_EM_RESTART': '1', 05:34:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:34:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:34:51 INFO - 'PWD': '/builds/slave/test-pgo', 05:34:51 INFO - 'SHELL': '/bin/bash', 05:34:51 INFO - 'SHLVL': '1', 05:34:51 INFO - 'TERM': 'linux', 05:34:51 INFO - 'TMOUT': '86400', 05:34:51 INFO - 'USER': 'cltbld', 05:34:51 INFO - 'XDG_SESSION_COOKIE': '20aa3857bbc5a756c598c738000001bb-1448458142.577917-117337063', 05:34:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:34:51 INFO - '_': '/tools/buildbot/bin/python'} 05:34:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:34:52 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 05:34:52 INFO - Cleaning up... 05:34:52 INFO - Return code: 0 05:34:52 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 05:34:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:34:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:34:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:34:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:34:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:34:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:34:52 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 0x1c54030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1db48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e817d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f10640>, '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 0x1f11540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f119d0>, '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': '20aa3857bbc5a756c598c738000001bb-1448458142.577917-117337063', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:34:52 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test-pgo/build 05:34:52 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 05:34:52 INFO - Using env: {'DISPLAY': ':0', 05:34:52 INFO - 'HOME': '/home/cltbld', 05:34:52 INFO - 'LANG': 'en_US.UTF-8', 05:34:52 INFO - 'LANGUAGE': 'en_US:en', 05:34:52 INFO - 'LOGNAME': 'cltbld', 05:34:52 INFO - 'MAIL': '/var/mail/cltbld', 05:34:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:34:52 INFO - 'MOZ_NO_REMOTE': '1', 05:34:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:34:52 INFO - 'NO_EM_RESTART': '1', 05:34:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:34:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:34:52 INFO - 'PWD': '/builds/slave/test-pgo', 05:34:52 INFO - 'SHELL': '/bin/bash', 05:34:52 INFO - 'SHLVL': '1', 05:34:52 INFO - 'TERM': 'linux', 05:34:52 INFO - 'TMOUT': '86400', 05:34:52 INFO - 'USER': 'cltbld', 05:34:52 INFO - 'XDG_SESSION_COOKIE': '20aa3857bbc5a756c598c738000001bb-1448458142.577917-117337063', 05:34:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:34:52 INFO - '_': '/tools/buildbot/bin/python'} 05:34:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:34:52 INFO - Downloading/unpacking psutil>=0.7.1 05:34:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:34:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:34:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:34:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:34:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:34:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:34:54 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 05:34:54 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 05:34:54 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 05:34:54 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:34:54 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:34:54 INFO - Installing collected packages: psutil 05:34:54 INFO - Running setup.py install for psutil 05:34:54 INFO - building 'psutil._psutil_linux' extension 05:34:54 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 05:34:55 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 05:34:55 INFO - building 'psutil._psutil_posix' extension 05:34:55 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 05:34:55 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 05:34:55 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:34:55 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:34:55 INFO - Successfully installed psutil 05:34:55 INFO - Cleaning up... 05:34:56 INFO - Return code: 0 05:34:56 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 05:34:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:34:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:34:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:34:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:34:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:34:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:34:56 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 0x1c54030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1db48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e817d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f10640>, '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 0x1f11540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f119d0>, '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': '20aa3857bbc5a756c598c738000001bb-1448458142.577917-117337063', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:34:56 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test-pgo/build 05:34:56 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 05:34:56 INFO - Using env: {'DISPLAY': ':0', 05:34:56 INFO - 'HOME': '/home/cltbld', 05:34:56 INFO - 'LANG': 'en_US.UTF-8', 05:34:56 INFO - 'LANGUAGE': 'en_US:en', 05:34:56 INFO - 'LOGNAME': 'cltbld', 05:34:56 INFO - 'MAIL': '/var/mail/cltbld', 05:34:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:34:56 INFO - 'MOZ_NO_REMOTE': '1', 05:34:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:34:56 INFO - 'NO_EM_RESTART': '1', 05:34:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:34:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:34:56 INFO - 'PWD': '/builds/slave/test-pgo', 05:34:56 INFO - 'SHELL': '/bin/bash', 05:34:56 INFO - 'SHLVL': '1', 05:34:56 INFO - 'TERM': 'linux', 05:34:56 INFO - 'TMOUT': '86400', 05:34:56 INFO - 'USER': 'cltbld', 05:34:56 INFO - 'XDG_SESSION_COOKIE': '20aa3857bbc5a756c598c738000001bb-1448458142.577917-117337063', 05:34:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:34:56 INFO - '_': '/tools/buildbot/bin/python'} 05:34:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:34:56 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 05:34:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:34:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:34:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:34:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:34:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:34:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:34:57 INFO - Downloading mozsystemmonitor-0.0.tar.gz 05:34:57 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 05:34:57 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:34:57 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 05:34:57 INFO - Installing collected packages: mozsystemmonitor 05:34:57 INFO - Running setup.py install for mozsystemmonitor 05:34:58 INFO - Successfully installed mozsystemmonitor 05:34:58 INFO - Cleaning up... 05:34:58 INFO - Return code: 0 05:34:58 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 05:34:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:34:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:34:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:34:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:34:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:34:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:34:58 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1c54030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1db48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e817d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f10640>, '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 0x1f11540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f119d0>, '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': '20aa3857bbc5a756c598c738000001bb-1448458142.577917-117337063', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:34:58 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test-pgo/build 05:34:58 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 05:34:58 INFO - Using env: {'DISPLAY': ':0', 05:34:58 INFO - 'HOME': '/home/cltbld', 05:34:58 INFO - 'LANG': 'en_US.UTF-8', 05:34:58 INFO - 'LANGUAGE': 'en_US:en', 05:34:58 INFO - 'LOGNAME': 'cltbld', 05:34:58 INFO - 'MAIL': '/var/mail/cltbld', 05:34:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:34:58 INFO - 'MOZ_NO_REMOTE': '1', 05:34:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:34:58 INFO - 'NO_EM_RESTART': '1', 05:34:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:34:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:34:58 INFO - 'PWD': '/builds/slave/test-pgo', 05:34:58 INFO - 'SHELL': '/bin/bash', 05:34:58 INFO - 'SHLVL': '1', 05:34:58 INFO - 'TERM': 'linux', 05:34:58 INFO - 'TMOUT': '86400', 05:34:58 INFO - 'USER': 'cltbld', 05:34:58 INFO - 'XDG_SESSION_COOKIE': '20aa3857bbc5a756c598c738000001bb-1448458142.577917-117337063', 05:34:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:34:58 INFO - '_': '/tools/buildbot/bin/python'} 05:34:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:34:58 INFO - Downloading/unpacking blobuploader==1.2.4 05:34:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:34:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:34:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:34:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:34:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:34:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:34:59 INFO - Downloading blobuploader-1.2.4.tar.gz 05:35:00 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 05:35:00 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:35:00 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:35:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:35:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:35:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:35:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:35:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:35:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:35:00 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 05:35:00 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 05:35:00 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:35:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:35:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:35:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:35:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:35:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:35:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:35:00 INFO - Downloading docopt-0.6.1.tar.gz 05:35:00 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 05:35:00 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 05:35:00 INFO - Installing collected packages: blobuploader, requests, docopt 05:35:00 INFO - Running setup.py install for blobuploader 05:35:01 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:35:01 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 05:35:01 INFO - Running setup.py install for requests 05:35:01 INFO - Running setup.py install for docopt 05:35:01 INFO - Successfully installed blobuploader requests docopt 05:35:01 INFO - Cleaning up... 05:35:01 INFO - Return code: 0 05:35:01 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 05:35:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:35:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:35:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:35:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:35:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:35:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:35:01 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 0x1c54030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1db48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e817d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f10640>, '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 0x1f11540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f119d0>, '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': '20aa3857bbc5a756c598c738000001bb-1448458142.577917-117337063', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:35:01 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/config 05:35:01 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --no-deps --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:35:01 INFO - Using env: {'DISPLAY': ':0', 05:35:01 INFO - 'HOME': '/home/cltbld', 05:35:01 INFO - 'LANG': 'en_US.UTF-8', 05:35:01 INFO - 'LANGUAGE': 'en_US:en', 05:35:01 INFO - 'LOGNAME': 'cltbld', 05:35:01 INFO - 'MAIL': '/var/mail/cltbld', 05:35:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:35:01 INFO - 'MOZ_NO_REMOTE': '1', 05:35:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:35:01 INFO - 'NO_EM_RESTART': '1', 05:35:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:35:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:35:01 INFO - 'PWD': '/builds/slave/test-pgo', 05:35:01 INFO - 'SHELL': '/bin/bash', 05:35:01 INFO - 'SHLVL': '1', 05:35:01 INFO - 'TERM': 'linux', 05:35:01 INFO - 'TMOUT': '86400', 05:35:01 INFO - 'USER': 'cltbld', 05:35:01 INFO - 'XDG_SESSION_COOKIE': '20aa3857bbc5a756c598c738000001bb-1448458142.577917-117337063', 05:35:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:35:01 INFO - '_': '/tools/buildbot/bin/python'} 05:35:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:35:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 05:35:01 INFO - Running setup.py (path:/tmp/pip-fYISoV-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 05:35:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 05:35:01 INFO - Running setup.py (path:/tmp/pip-sZOhRm-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 05:35:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 05:35:01 INFO - Running setup.py (path:/tmp/pip-9PTAQv-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 05:35:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 05:35:01 INFO - Running setup.py (path:/tmp/pip-7FIyye-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 05:35:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 05:35:02 INFO - Running setup.py (path:/tmp/pip-2E8DNV-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 05:35:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 05:35:02 INFO - Running setup.py (path:/tmp/pip-fF7R3I-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 05:35:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 05:35:02 INFO - Running setup.py (path:/tmp/pip-XqPudI-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 05:35:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 05:35:02 INFO - Running setup.py (path:/tmp/pip-S9KE_i-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 05:35:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 05:35:02 INFO - Running setup.py (path:/tmp/pip-fHfJvY-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 05:35:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 05:35:02 INFO - Running setup.py (path:/tmp/pip-tTNavz-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 05:35:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 05:35:02 INFO - Running setup.py (path:/tmp/pip-DCuxnV-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 05:35:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 05:35:02 INFO - Running setup.py (path:/tmp/pip-v08p_h-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 05:35:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 05:35:02 INFO - Running setup.py (path:/tmp/pip-qDggX3-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 05:35:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 05:35:02 INFO - Running setup.py (path:/tmp/pip-kBAbgc-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 05:35:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 05:35:02 INFO - Running setup.py (path:/tmp/pip-KvyUw2-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 05:35:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 05:35:02 INFO - Running setup.py (path:/tmp/pip-aGpxyd-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 05:35:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 05:35:02 INFO - Running setup.py (path:/tmp/pip-OpZ5UV-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 05:35:02 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:35:02 INFO - Running setup.py install for manifestparser 05:35:03 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 05:35:03 INFO - Running setup.py install for mozcrash 05:35:03 INFO - Running setup.py install for mozdebug 05:35:03 INFO - Running setup.py install for mozdevice 05:35:03 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 05:35:03 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 05:35:03 INFO - Running setup.py install for mozfile 05:35:03 INFO - Running setup.py install for mozhttpd 05:35:03 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 05:35:03 INFO - Running setup.py install for mozinfo 05:35:03 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 05:35:03 INFO - Running setup.py install for mozInstall 05:35:03 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 05:35:03 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 05:35:03 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 05:35:03 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 05:35:03 INFO - Running setup.py install for mozleak 05:35:03 INFO - Running setup.py install for mozlog 05:35:04 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 05:35:04 INFO - Running setup.py install for moznetwork 05:35:04 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 05:35:04 INFO - Running setup.py install for mozprocess 05:35:04 INFO - Running setup.py install for mozprofile 05:35:04 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 05:35:04 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 05:35:04 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 05:35:04 INFO - Running setup.py install for mozrunner 05:35:04 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 05:35:04 INFO - Running setup.py install for mozscreenshot 05:35:04 INFO - Running setup.py install for moztest 05:35:04 INFO - Running setup.py install for mozversion 05:35:04 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 05:35:04 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:35:04 INFO - Cleaning up... 05:35:04 INFO - Return code: 0 05:35:04 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 05:35:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:35:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:35:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:35:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:35:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:35:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:35:04 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 0x1c54030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1db48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e817d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f10640>, '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 0x1f11540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f119d0>, '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': '20aa3857bbc5a756c598c738000001bb-1448458142.577917-117337063', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:35:04 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/config 05:35:04 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:35:04 INFO - Using env: {'DISPLAY': ':0', 05:35:04 INFO - 'HOME': '/home/cltbld', 05:35:04 INFO - 'LANG': 'en_US.UTF-8', 05:35:04 INFO - 'LANGUAGE': 'en_US:en', 05:35:04 INFO - 'LOGNAME': 'cltbld', 05:35:04 INFO - 'MAIL': '/var/mail/cltbld', 05:35:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:35:04 INFO - 'MOZ_NO_REMOTE': '1', 05:35:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:35:04 INFO - 'NO_EM_RESTART': '1', 05:35:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:35:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:35:04 INFO - 'PWD': '/builds/slave/test-pgo', 05:35:04 INFO - 'SHELL': '/bin/bash', 05:35:04 INFO - 'SHLVL': '1', 05:35:04 INFO - 'TERM': 'linux', 05:35:04 INFO - 'TMOUT': '86400', 05:35:04 INFO - 'USER': 'cltbld', 05:35:04 INFO - 'XDG_SESSION_COOKIE': '20aa3857bbc5a756c598c738000001bb-1448458142.577917-117337063', 05:35:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:35:04 INFO - '_': '/tools/buildbot/bin/python'} 05:35:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:35:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 05:35:05 INFO - Running setup.py (path:/tmp/pip-a8aQez-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 05:35:05 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 1)) 05:35:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 05:35:05 INFO - Running setup.py (path:/tmp/pip-_xJYZu-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 05:35:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.16 from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 05:35:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 05:35:05 INFO - Running setup.py (path:/tmp/pip-hfMqtB-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 05:35:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 3)) 05:35:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 05:35:05 INFO - Running setup.py (path:/tmp/pip-HGkJ56-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 05:35:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.47 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 05:35:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 05:35:05 INFO - Running setup.py (path:/tmp/pip-riUVmu-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 05:35:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 5)) 05:35:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 05:35:05 INFO - Running setup.py (path:/tmp/pip-cQ28aQ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 05:35:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 6)) 05:35:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 05:35:05 INFO - Running setup.py (path:/tmp/pip-ammwDc-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 05:35:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 7)) 05:35:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 05:35:05 INFO - Running setup.py (path:/tmp/pip-Sytk9e-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 05:35:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 8)) 05:35:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 05:35:05 INFO - Running setup.py (path:/tmp/pip-rydSMo-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 05:35:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 9)) 05:35:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 05:35:05 INFO - Running setup.py (path:/tmp/pip-5BdADF-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 05:35:05 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)) 05:35:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 05:35:05 INFO - Running setup.py (path:/tmp/pip-ZUUDuJ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 05:35:05 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 11)) 05:35:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 05:35:05 INFO - Running setup.py (path:/tmp/pip-zrFLGs-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 05:35:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 12)) 05:35:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 05:35:05 INFO - Running setup.py (path:/tmp/pip-mdksxl-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 05:35:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.27 from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 13)) 05:35:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 05:35:05 INFO - Running setup.py (path:/tmp/pip-gcL4EK-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 05:35:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 14)) 05:35:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 05:35:06 INFO - Running setup.py (path:/tmp/pip-QDHRhH-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 05:35:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 15)) 05:35:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 05:35:06 INFO - Running setup.py (path:/tmp/pip-DMIP9f-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 05:35:06 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test-pgo/build/tests/mozbase/moztest in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 16)) 05:35:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 05:35:06 INFO - Running setup.py (path:/tmp/pip-NwkMfN-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 05:35:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 17)) 05:35:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 05:35:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 05:35:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 3)) 05:35:06 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 05:35:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 05:35:06 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 05:35:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:35:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:35:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:35:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:35:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:35:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:35:07 INFO - Downloading blessings-1.5.1.tar.gz 05:35:07 INFO - Storing download in cache at /builds/slave/test-pgo/build/venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblessings-1.5.1.tar.gz 05:35:07 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 05:35:07 INFO - Installing collected packages: blessings 05:35:07 INFO - Running setup.py install for blessings 05:35:08 INFO - Successfully installed blessings 05:35:08 INFO - Cleaning up... 05:35:08 INFO - Return code: 0 05:35:08 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 05:35:08 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 05:35:08 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 05:35:08 INFO - Reading from file tmpfile_stdout 05:35:08 INFO - Current package versions: 05:35:08 INFO - argparse == 1.2.1 05:35:08 INFO - blessings == 1.5.1 05:35:08 INFO - blobuploader == 1.2.4 05:35:08 INFO - docopt == 0.6.1 05:35:08 INFO - manifestparser == 1.1 05:35:08 INFO - mozInstall == 1.12 05:35:08 INFO - mozcrash == 0.16 05:35:08 INFO - mozdebug == 0.1 05:35:08 INFO - mozdevice == 0.47 05:35:08 INFO - mozfile == 1.2 05:35:08 INFO - mozhttpd == 0.7 05:35:08 INFO - mozinfo == 0.9 05:35:08 INFO - mozleak == 0.1 05:35:08 INFO - mozlog == 3.1 05:35:08 INFO - moznetwork == 0.27 05:35:08 INFO - mozprocess == 0.22 05:35:08 INFO - mozprofile == 0.27 05:35:08 INFO - mozrunner == 6.11 05:35:08 INFO - mozscreenshot == 0.1 05:35:08 INFO - mozsystemmonitor == 0.0 05:35:08 INFO - moztest == 0.7 05:35:08 INFO - mozversion == 1.4 05:35:08 INFO - psutil == 3.1.1 05:35:08 INFO - requests == 1.2.3 05:35:08 INFO - wsgiref == 0.1.2 05:35:08 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 05:35:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:35:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:35:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:35:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:35:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:35:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:35:08 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 0x1c54030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1db48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e817d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f10640>, '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 0x1f11540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f119d0>, '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': '20aa3857bbc5a756c598c738000001bb-1448458142.577917-117337063', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:35:08 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/talos 05:35:08 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 -r /builds/slave/test-pgo/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:35:08 INFO - Using env: {'DISPLAY': ':0', 05:35:08 INFO - 'HOME': '/home/cltbld', 05:35:08 INFO - 'LANG': 'en_US.UTF-8', 05:35:08 INFO - 'LANGUAGE': 'en_US:en', 05:35:08 INFO - 'LOGNAME': 'cltbld', 05:35:08 INFO - 'MAIL': '/var/mail/cltbld', 05:35:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:35:08 INFO - 'MOZ_NO_REMOTE': '1', 05:35:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:35:08 INFO - 'NO_EM_RESTART': '1', 05:35:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:35:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:35:08 INFO - 'PWD': '/builds/slave/test-pgo', 05:35:08 INFO - 'SHELL': '/bin/bash', 05:35:08 INFO - 'SHLVL': '1', 05:35:08 INFO - 'TERM': 'linux', 05:35:08 INFO - 'TMOUT': '86400', 05:35:08 INFO - 'USER': 'cltbld', 05:35:08 INFO - 'XDG_SESSION_COOKIE': '20aa3857bbc5a756c598c738000001bb-1448458142.577917-117337063', 05:35:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:35:08 INFO - '_': '/tools/buildbot/bin/python'} 05:35:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:35:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 05:35:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 2)) 05:35:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 3)) 05:35:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 4)) 05:35:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 5)) 05:35:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 6)) 05:35:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 7)) 05:35:08 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 8)) 05:35:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash>=0.15->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 05:35:08 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 3)) 05:35:08 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozlog>=3.0->mozcrash>=0.15->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 05:35:08 INFO - Cleaning up... 05:35:08 INFO - Return code: 0 05:35:08 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 05:35:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:35:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:35:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:35:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:35:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:35:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:35:08 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 0x1c54030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1db48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e817d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f10640>, '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 0x1f11540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f119d0>, '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': '20aa3857bbc5a756c598c738000001bb-1448458142.577917-117337063', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:35:08 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 05:35:08 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 05:35:08 INFO - Using env: {'DISPLAY': ':0', 05:35:08 INFO - 'HOME': '/home/cltbld', 05:35:08 INFO - 'LANG': 'en_US.UTF-8', 05:35:08 INFO - 'LANGUAGE': 'en_US:en', 05:35:08 INFO - 'LOGNAME': 'cltbld', 05:35:08 INFO - 'MAIL': '/var/mail/cltbld', 05:35:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:35:08 INFO - 'MOZ_NO_REMOTE': '1', 05:35:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:35:08 INFO - 'NO_EM_RESTART': '1', 05:35:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:35:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:35:08 INFO - 'PWD': '/builds/slave/test-pgo', 05:35:08 INFO - 'SHELL': '/bin/bash', 05:35:08 INFO - 'SHLVL': '1', 05:35:08 INFO - 'TERM': 'linux', 05:35:08 INFO - 'TMOUT': '86400', 05:35:08 INFO - 'USER': 'cltbld', 05:35:08 INFO - 'XDG_SESSION_COOKIE': '20aa3857bbc5a756c598c738000001bb-1448458142.577917-117337063', 05:35:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:35:08 INFO - '_': '/tools/buildbot/bin/python'} 05:35:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:35:08 INFO - Downloading/unpacking jsonschema 05:35:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:35:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:35:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:35:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:35:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:35:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:35:10 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:35:10 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 05:35:10 INFO - Downloading/unpacking functools32 (from jsonschema) 05:35: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 05:35: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 05:35: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 05:35: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 05:35: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 05:35: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 05:35:10 INFO - Downloading functools32-3.2.3-2.tar.gz 05:35:10 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 05:35:10 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 05:35:10 INFO - warning: no files found matching '*.txt' 05:35:10 INFO - no previously-included directories found matching 'build' 05:35:10 INFO - no previously-included directories found matching 'dist' 05:35:10 INFO - no previously-included directories found matching '.git*' 05:35:10 INFO - Installing collected packages: jsonschema, functools32 05:35:10 INFO - Running setup.py install for functools32 05:35:10 INFO - warning: no files found matching '*.txt' 05:35:10 INFO - no previously-included directories found matching 'build' 05:35:10 INFO - no previously-included directories found matching 'dist' 05:35:10 INFO - no previously-included directories found matching '.git*' 05:35:10 INFO - Successfully installed jsonschema functools32 05:35:10 INFO - Cleaning up... 05:35:10 INFO - Return code: 0 05:35:10 INFO - Running post-action listener: _resource_record_post_action 05:35:10 INFO - Running post-action listener: _start_resource_monitoring 05:35:10 INFO - Starting resource monitoring. 05:35:10 INFO - ##### 05:35:10 INFO - ##### Running install step. 05:35:10 INFO - ##### 05:35:10 INFO - Running pre-action listener: _resource_record_pre_action 05:35:10 INFO - Running main action method: install 05:35:10 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 05:35:10 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 05:35:11 INFO - Reading from file tmpfile_stdout 05:35:11 INFO - Detecting whether we're running mozinstall >=1.0... 05:35:11 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 05:35:11 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 05:35:11 INFO - Reading from file tmpfile_stdout 05:35:11 INFO - Output received: 05:35:11 INFO - Usage: mozinstall [options] installer 05:35:11 INFO - Options: 05:35:11 INFO - -h, --help show this help message and exit 05:35:11 INFO - -d DEST, --destination=DEST 05:35:11 INFO - Directory to install application into. [default: 05:35:11 INFO - "/builds/slave/test-pgo"] 05:35:11 INFO - --app=APP Application being installed. [default: firefox] 05:35:11 INFO - mkdir: /builds/slave/test-pgo/build/application 05:35:11 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test-pgo/build/application'] 05:35:11 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test-pgo/build/application 05:35:25 INFO - Reading from file tmpfile_stdout 05:35:25 INFO - Output received: 05:35:25 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 05:35:25 INFO - Running post-action listener: _resource_record_post_action 05:35:25 INFO - ##### 05:35:25 INFO - ##### Running run-tests step. 05:35:25 INFO - ##### 05:35:25 INFO - Running pre-action listener: _resource_record_pre_action 05:35:25 INFO - Running main action method: run_tests 05:35:25 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 05:35:25 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 05:35:25 INFO - Python 2.7.3 05:35:25 INFO - Return code: 0 05:35:25 INFO - grabbing minidump binary from tooltool 05:35:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:35:25 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 0x1f10640>, '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 0x1f11540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f119d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 05:35:25 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test-pgo/build 05:35:25 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 05:35:26 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:35:26 INFO - Return code: 0 05:35:26 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 05:35:26 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 05:35:26 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 05:35:26 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 05:35:26 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 05:35:26 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/K7V4RDtZQ_2QUQmqJz7NIg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-065', '--webServer', 'localhost'] in /builds/slave/test-pgo/build 05:35:26 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --debug --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/K7V4RDtZQ_2QUQmqJz7NIg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-065 --webServer localhost 05:35:26 INFO - Using env: {'DISPLAY': ':0', 05:35:26 INFO - 'HOME': '/home/cltbld', 05:35:26 INFO - 'LANG': 'en_US.UTF-8', 05:35:26 INFO - 'LANGUAGE': 'en_US:en', 05:35:26 INFO - 'LOGNAME': 'cltbld', 05:35:26 INFO - 'MAIL': '/var/mail/cltbld', 05:35:26 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 05:35:26 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 05:35:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:35:26 INFO - 'MOZ_NO_REMOTE': '1', 05:35:26 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 05:35:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:35:26 INFO - 'NO_EM_RESTART': '1', 05:35:26 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:35:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:35:26 INFO - 'PWD': '/builds/slave/test-pgo', 05:35:26 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 05:35:26 INFO - 'SHELL': '/bin/bash', 05:35:26 INFO - 'SHLVL': '1', 05:35:26 INFO - 'TERM': 'linux', 05:35:26 INFO - 'TMOUT': '86400', 05:35:26 INFO - 'USER': 'cltbld', 05:35:26 INFO - 'XDG_SESSION_COOKIE': '20aa3857bbc5a756c598c738000001bb-1448458142.577917-117337063', 05:35:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:35:26 INFO - '_': '/tools/buildbot/bin/python'} 05:35:26 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/K7V4RDtZQ_2QUQmqJz7NIg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-065', '--webServer', 'localhost'] with output_timeout 3600 05:35:26 INFO - mozversion INFO | application_buildid: 20151125030231 05:35:26 INFO - mozversion INFO | application_changeset: 099f695d31326c39595264c34988a0f4b7cbc698 05:35:26 INFO - mozversion INFO | application_display_name: Nightly 05:35:26 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:35:26 INFO - mozversion INFO | application_name: Firefox 05:35:26 INFO - mozversion INFO | application_remotingname: firefox 05:35:26 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/mozilla-central 05:35:26 INFO - mozversion INFO | application_vendor: Mozilla 05:35:26 INFO - mozversion INFO | application_version: 45.0a1 05:35:26 INFO - mozversion INFO | platform_buildid: 20151125030231 05:35:26 INFO - mozversion INFO | platform_changeset: 099f695d31326c39595264c34988a0f4b7cbc698 05:35:26 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/mozilla-central 05:35:26 INFO - mozversion INFO | platform_version: 45.0a1 05:35:26 INFO - 2015-11-25 05:35:26,334 DEBUG : using testdate: 1448458526 05:35:26 INFO - 2015-11-25 05:35:26,334 DEBUG : actual date: 1448458526 05:35:26 INFO - 2015-11-25 05:35:26,419 INFO : starting webserver on 'localhost:57653' 05:35:26 INFO - 2015-11-25 05:35:26,420 INFO : Starting test suite talos-linux64-ix-065.e 05:35:26 INFO - 2015-11-25 05:35:26,420 INFO : Starting test dromaeo_css 05:35:26 INFO - 2015-11-25 05:35:26,420 DEBUG : operating with platform_type : linux_ 05:35:26 INFO - 2015-11-25 05:35:26,421 INFO : Initialising browser for dromaeo_css test... 05:35:26 INFO - 2015-11-25 05:35:26,440 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpaqb4Be/profile http://localhost:57653/getInfo.html 05:35:34 INFO - 2015-11-25 05:35:34,040 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 05:35:34 INFO - 2015-11-25 05:35:34,040 DEBUG : BROWSER_OUTPUT: colorDepth:24 05:35:34 INFO - 2015-11-25 05:35:34,040 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/668 05:35:34 INFO - 2015-11-25 05:35:34,040 DEBUG : BROWSER_OUTPUT: __metrics 05:35:35 INFO - 2015-11-25 05:35:35,575 INFO : Browser initialized. 05:35:35 INFO - 2015-11-25 05:35:35,575 INFO : Running cycle 1/1 for dromaeo_css test... 05:35:35 INFO - 2015-11-25 05:35:35,575 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpaqb4Be/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 05:35:47 INFO - 2015-11-25 05:35:47,298 DEBUG : BROWSER_OUTPUT: RSS: Main: 138932224 05:35:47 INFO - 2015-11-25 05:35:47,299 DEBUG : BROWSER_OUTPUT: 05:36:36 INFO - 2015-11-25 05:36:36,905 DEBUG : BROWSER_OUTPUT: 1448458596901 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 05:38:46 INFO - 2015-11-25 05:38:46,015 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57653/tests/dromaeo/cssquery-dojo.html (next: http://localhost:57653/tests/dromaeo/cssquery-ext.html) 05:38:47 INFO - 2015-11-25 05:38:47,032 DEBUG : BROWSER_OUTPUT: RSS: Main: 148856832 05:38:47 INFO - 2015-11-25 05:38:47,032 DEBUG : BROWSER_OUTPUT: 05:41:48 INFO - 2015-11-25 05:41:48,928 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57653/tests/dromaeo/cssquery-ext.html (next: http://localhost:57653/tests/dromaeo/cssquery-jquery.html) 05:41:49 INFO - 2015-11-25 05:41:49,515 DEBUG : BROWSER_OUTPUT: RSS: Main: 142737408 05:41:49 INFO - 2015-11-25 05:41:49,515 DEBUG : BROWSER_OUTPUT: 05:44:51 INFO - 2015-11-25 05:44:51,164 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57653/tests/dromaeo/cssquery-jquery.html (next: http://localhost:57653/tests/dromaeo/cssquery-mootools.html) 05:44:51 INFO - 2015-11-25 05:44:51,745 DEBUG : BROWSER_OUTPUT: RSS: Main: 145063936 05:44:51 INFO - 2015-11-25 05:44:51,746 DEBUG : BROWSER_OUTPUT: 05:47:53 INFO - 2015-11-25 05:47:53,370 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57653/tests/dromaeo/cssquery-mootools.html (next: http://localhost:57653/tests/dromaeo/cssquery-prototype.html) 05:47:53 INFO - 2015-11-25 05:47:53,976 DEBUG : BROWSER_OUTPUT: RSS: Main: 142692352 05:47:53 INFO - 2015-11-25 05:47:53,976 DEBUG : BROWSER_OUTPUT: 05:50:56 INFO - 2015-11-25 05:50:56,210 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57653/tests/dromaeo/cssquery-prototype.html (next: http://localhost:57653/tests/dromaeo/cssquery-yui.html) 05:50:56 INFO - 2015-11-25 05:50:56,796 DEBUG : BROWSER_OUTPUT: RSS: Main: 141492224 05:50:56 INFO - 2015-11-25 05:50:56,796 DEBUG : BROWSER_OUTPUT: 05:53:59 INFO - 2015-11-25 05:53:59,422 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57653/tests/dromaeo/cssquery-yui.html (next: http://localhost:57653/tests/dromaeo/cssquery-dojo.html) 05:53:59 INFO - 2015-11-25 05:53:59,680 DEBUG : BROWSER_OUTPUT: RSS: Main: 145076224 05:53:59 INFO - 2015-11-25 05:53:59,680 DEBUG : BROWSER_OUTPUT: 05:53:59 INFO - 2015-11-25 05:53:59,680 DEBUG : BROWSER_OUTPUT: __start_tp_report 05:53:59 INFO - 2015-11-25 05:53:59,681 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 05:53:59 INFO - 2015-11-25 05:53:59,681 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 05:53:59 INFO - 2015-11-25 05:53:59,681 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 05:53:59 INFO - 2015-11-25 05:53:59,681 DEBUG : BROWSER_OUTPUT: |0;dojo.html;3199.9360012799743;3262.8857989970356;3287.5068739689027;3298.3568204200174;3309.735221182305;5293.8941221175555;5434.3207099112615;5456.590755693324;5474.562035037197;5489.91765123523;5375.865603359908;5397.298351214346;5441.59188060896;5574.777008919638;5601.80393686221;5041.974790126044;5096.898062038757;5145.74271286436;5166.044281807859;5171.870703232412;5021.221710634839;5055.418626857903;5103.3875934887865;5150.072986862363;5165.173572228444;4870.366852309195;4944.8269310574315;4978.377702787152;5016.698998060128;5063.088644044071;5012.473690262543;5029.321041659366;5049.899002019975;5058.038972595232;5084.593232541425;5010.824621138279;5015.824446144404;5047.848564543069;5051.419086804991;5055.5702765265;5138.100832354323;5244.685318880879;5262.394824595182;5332.200169974496;5352;5959.165716799652;6016.916954948108;6023.849403764897;6026.6986650667295;6042.6978651067275;5726.112452569859;6014.30835453924;6021.1269365942135;6026.156338112668;6031.853947749957;5489.917651235235;5567.8886422271735;5631.71841407928;5635.267415235993;5672.773089076473;6088.908666370008;6090.147379366892;6090.299615544181;6104.145419641254;6106.1146133811235;5614.410486898899;5707.143928410772;5885.705714714333;5886.970565147147;5893.263342082239;5871.823845284648;5912.438318359749;5916.319623243382;5922.555808314393;5929.644221346647;5824.097264923944;5877.764889404376;5916.437938395846;5919.763209471659;5929.466348028698;5722.313322401338;5777.133429985452;5823.941760582425;5915.704214789243;5926.407359264039;4612.469565999953;4619.099275641218;4619.514950930171;4621.560951709582;4630.768461576908;4123.690723195772;4126.401671757579;4134.979325103355;4138.006878349234;4164.187983343219;5503.147012213113;5581.134924086773;5632.7746890123935;5730.799422020209;5752.964466396089;5913.970430147821;5961.880762384728;5986.2217911671205;6010.699465026732;6012.879742405127;5649.943500564942;5676.290463692038;5691.658500489983;5692.743826527816;5702.800401985911;4931.112399768004;5066.695998240118;5105.106606343875;5133.6919784813035;5189.610779191576;6108.419700128481;6197.287311959182;6199.938000620026;6200.007998720183;6202.162708034538;6002.969985150046;6006.87986240264;6015.338312785502;6031.336552979081;6042.697865106815;5797.623154494944;5969.582129250911;5988.820335389771;6099.672983688876;6128.417800308964;5911.172435858897;5912.940870591411;5939.46544810969;5944.494717949023;5947.405259474191;5804.071348584206;5998.400159984141;6014.218151640259;6044.15381846533;6048.183495228088;5690.715464226855;5774.855628609318;5861.9706901465215;5869.970650146722;5921.5854890159;5833.620814647034;5869.8239052828485;5872.853178670567;5884.0585506318785;5902.2622172228475;5553.972230138824;5669.858253543694;5762.250907382014;5781.537477001746;5783;5716.28546431696;5812.18629391877;5812.912806307993;5814.883702325845;5824.039033559585;5627.88744225105;5628.493435590816;5654.123610840326;5678.943210568007;5679.74441150141 05:53:59 INFO - 2015-11-25 05:53:59,681 DEBUG : BROWSER_OUTPUT: |1;ext.html;580.1471836400495;586.5776640818609;591.9289685237773;592.7332700284873;594.1473984831769;32242;40705.79647101764;40829.97925051875;41044.58955410445;41125;42643.57356426435;43110;43147.99999999992;43302.35046474305;43310.35034474485;8497.617607207674;8735.563221838915;8756.255718263956;8762.912370876305;8804.559772011406;8501.744947651581;8632.568371581427;8635.870461943075;8649.394542382035;8656.047834738174;8581.656733730642;8659.870101948476;8660.090690477504;8734.912650873504;8735.301175905912;8614.698485553006;8677;8707.216350528452;8716.08481109484;8719.433236839648;8508.191721786421;8656.913430865674;8682.522461264627;8698.521581313025;8726.738197854074;41091.58908410907;41415.585844141475;41591;41676.37485437721;41714.1657166858;3249.772515923886;3294.7199488043307;3311.768176227665;3325.1022223999385;3367.1582104473882;29854.552181717292;30229;30437.782488700424;30745.692543074507;31430.842845785854;3646.2707458508403;3666.871659491905;3711.851525938986;3753.0429740416293;3832.7891965941863;268978;269382;271220;271765;272546;53213;53906.19140712892;59204.703976480705;59578.106328405105;67846.32153678499;63606.363936360045;63809;63847.36152638507;63902.680486597266;64158;15395.230238488031;15556.455524056604;15602.375904963901;15624.609384765245;15638.687226255412;10507.264491485676;10538.156947444186;10579.10077643409;10594.947025264979;10597.417142057107;20236.291729789387;20575.58848823015;20687.8965605171;20903.79096209049;20934.895325523274;7340.641981233489;7377.594232317167;7472.589007604634;7520.586367749717;7587.089549254125;895.5029958373166;983.6360546597662;1047.0994944347856;1053.5627714498398;1078.4230436716318;28128.43743125126;28373;28877.855610721814;28951.56572651412;28988.85505572501;1090.7218659241842;1112.1769890281296;1112.7273817914663;1130.0225305111185;1172.050638982427;13761.931190343985;14267.215303158218;14294.714105717827;14346.784798228035;14609.561713148623;326152;330427;331247;331354;331943;52090.21864672033;52147;52563.21155182675;52585.47414525806;52615.21077183845;1286.0997301888715;1320.2804471563022;1335.2455862437691;1337.190999445341;1352.425219281821;26934.730652693223;27915.302117447227;28070.85964570164;28335.29161770972;29153.85423072871;44382.77808610936;44434.11131777411;44881.32678009767;44945.10109797851;45102.77448612736;224321;225533;225645;225808;226076;31203.84398077995;31339.373212536077;31743.52384714185;31848.681513184572;32183.51724724084;39648.20703585855;41908;42518.574814251464;43291.78354108335;43593.78203109091;35063.64936350604;36046.639533605376;36153.819230903675;36357.09107272339;36630;33169.50245746364;33801.323973520884;33809;33999;36672.81663591665;34675;35127.47308790319;35407.645923541466;35515;35570.288594228485;31832.840835795672;32538.965102765087;32615.836920815244;32875.67124328822;33250.50124248186;25297.62053569235;26798.59802103009;26915;26958;27033.86483067572 05:53:59 INFO - 2015-11-25 05:53:59,682 DEBUG : BROWSER_OUTPUT: |2;jquery.html;351.1186920828719;353.6145601294588;358.1351037245053;358.35674963440624;358.9802560859152;16623.83376166238;17232.396866109688;17604;18151.092445377744;18200.4539863804;14626.341814618341;14848;15061.39754409825;15161.393544258217;15234.695306093872;4779.545943135397;4927.482614325498;4966.329545511364;4974.527419895122;4980.402351717799;4975.179095449264;5020.0712868119335;5025.271335656346;5025.698458092508;5029.9748501257445;4867.36724225852;4954.628402869781;5047.520485553867;5174.249733788598;5204.531592156705;5079.542841144296;5095.980803839247;5112.948870511303;5113.514216149497;5235.319408476912;5217.321748172713;5230.398504172031;5237.4500677428705;5255.39562950258;5260.026895024433;12453;15364.769528457082;18962.43112706621;19877.30429434963;19933.601327973505;2040.0207900207984;2075.2217918280644;2120.9151633934625;2135.4981579328846;2145.4850835799452;9782.608695652165;9995.550200240934;11246.943765281203;12950.158239714388;13436.664083397896;1759.6216813385056;1896.2888916656254;1896.6680830854684;1896.7913529511743;1899.373206841739;62689.68655156695;64529.67735161294;64968.350316496704;65101;66197;9413;9509.381890177116;9636.518174091407;9637.518124093907;9665.275104367201;12402.875971240353;12459.439325230387;12558.434870430852;12575.371231438392;12622.621321360373;7053.858922821515;7137.750178743823;7147.678354474061;7166.889132184519;7483.850322993619;6738.764143254963;6847;6878.105846239957;6905.343992320722;6978.127734033246;4290.892727681833;4339.479262488521;4366.214081465367;4388.692791504564;4458.130664520388;1801.3155001099499;1811.085401872046;1821.9089045547669;1865.5709186887093;1880.6332765110947;909.2544113826599;966.2173639352147;968.8934217236099;976.6679329028165;983.5229913491951;14912.956093073597;15976.920115399582;17212.311507539558;17665.911670441565;18158.45524634263;936.2603543200931;941.1294552538874;943.429225318686;965.285688590438;967.0571193086685;9553.283503737248;9653.662121825702;9804.166645835041;9847.409155450696;9897.80204395908;532463;536997;546174;549407;554420;78078;78843.60578197187;79782;80204;80552;1145.7250259937555;1153.8903804138592;1160.5531870229854;1163.662537864027;1164.5050853387277;15166.620834479227;15181.696366072838;15263;15286;15479.458218962282;34867;35068.298634027684;35267.82366088153;35510;36713.632863671024;48791.75604121957;48841.26738099002;50532.24201636905;51731.96536069333;52083;9453.33826632129;9578.473183974947;9585.233181345615;9678.128968392879;9680.709578712649;15717.214139293219;16594.834051659327;16708.164591770605;16925.407610733564;16958.660826783642;13635.318234088058;13968.092074015156;14150.575482735534;14399;14632.268386580416;14409.639759006108;14437.422503099759;14569;15014.324355404251;15107.244637767848;14942.551723448314;15139.167345796088;15170.165640889856;15473;15570.377184912477;9311.72064838056;9576.425414475154;9579.616815327308;9649.46927918943;9835.409875407498;14628.634284142981;14672.633184170054;14841.554753357417;14862.479813206486;14982.708061466907 05:53:59 INFO - 2015-11-25 05:53:59,683 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1492.02272511505;1697.3974239145102;1714.5285046612187;1728.3345911823944;1765.161548264574;7044.401225895798;7141.500094993353;7348.926510734905;7491.625418729062;7492.662830172649;7107.147142342913;7194.352508274254;7214.314640109194;7221.9277807221915;7230.96384518078;1996.3212507747398;2039.39837747864;2042.6416433071988;2042.908069136885;2044.8773073615557;2170.9457263568456;2225.9888700556476;2246.9438264043365;2247.438140464884;2253.3690566641367;2186.2348178137604;2200.119952019197;2215.3132528916008;2223.566404551113;2226.6548684953777;2070.2960993262286;2096.4130043587743;2097.402240361497;2097.5595125023765;2098.9685154722692;2181.5418762059985;2248.730152381708;2275.8520696154696;2280.065173278948;2280.9429764256024;7241.601711905843;7336.853262934711;7341;7379.59412232327;7385.335319821188;4320.4599425071865;4375.234333991539;4375.78121093944;4376.23415902219;4389.836693276285;2930.868110935013;2941.76465882731;2984.7761417893526;2987.118799954019;3005.9398812023855;903.5888670654837;914.862770584411;917.9856258833959;975.2393133355923;979.2459805949379;9776.462294573796;9835.557399917021;9885.159761420287;9927.106560409598;9949.154321882721;4043.7775922324554;4048.21059893318;4112.794360281974;4114.732542384735;4128.876133715993;8546.743597692079;8567.528785916835;8568.871466928002;8575.1424857515;8578.528180950108;4440.289553671397;4447.2439685253585;4452.198604251201;4485.596296333346;4487.192305385062;3938.330483817758;4046.3323551614244;4073.7759423232005;4113.732607380511;4128.958710412918;3430.879919202816;3469.323481921001;3475.270193259393;3504.229069604683;3504.9649503505148;1083.4853444613746;1102.1513434655271;1105.8175401058895;1110.4059328259343;1115.6987613344352;947.052947052947;960.519740129935;966.3477152921749;1059.89930956559;1353.4653811744306;6717.227518835299;6730;6744.156980377453;6777.898331525031;6826.93173068263;457.3345781887346;1172.4255114993591;1191.8986886114778;1195.205188549622;1207.4264724255909;5509.201165831012;5515.7242137892945;5568.749406276727;5577.6932268724795;5615.466530679579;8291.33669306454;8389.664413423518;8606.096359882122;8639.740807775777;8648.221660050625;8616.48301101936;8631.007434145027;8653.870191947126;8704.869426958601;8739.56302184901;6903.309669033057;6910.827229319308;6936.965315173493;6965.442764578822;6966.303369662993;6473;6519.152510173647;6524.478041756743;6567.638779867153;6590.308017658077;7642.197569255371;7751.7674469766;7845.5684937329;7918.326942209746;7993.12075671664;7862.1351651319455;8077.636506357346;8107.270345668918;8169.387295952709;8170.468919520212;6331.90502142459;6335.1130841683125;6385.13800636908;6597.340265973365;6641.070250165078;7147;7167.820804479929;7187.281271872771;7192.460565457507;7203.71185152588;6621.933780662324;6739.6967136478;6758.357955994173;6787.796366109024;6909.723611055702;6589.670516474253;6661.900071499028;6715.966420167868;6735.797926062226;6746.932530674827;6624.337566243337;6637.303083176197;6684.364985326386;6694.397504224448;6699.698513566804;5988.011978023577;5998.070299103646;6060.303065147565;6064.666443345658;6069.51443884497;6186.072089186658;6251.6561589113035;6279.309275979547;6279.686015699288;6293.590916590407 05:53:59 INFO - 2015-11-25 05:53:59,686 DEBUG : BROWSER_OUTPUT: |4;prototype.html;301.22885413341845;309.8512713897329;320.6809224821303;322.38907270721967;323.90768630940187;6178.382161783825;6277.435030847223;6333.841653958653;6388.680565971695;6481.351864813516;6284.622922624646;6331.176946996896;6355.173827402443;6356.5868218565765;6362.395572420613;4800.159972004903;4804.399450068741;4805.879853003668;4809.230523116294;4818.734969576672;4791.856244312677;4799.592034677056;4805.927911081337;4806.038792241566;4808.711477311355;4662.8134874604975;4743.85768426946;4748.406449193851;4748.810047598092;4748.976255118737;4716.952830471686;4718.693284936468;4719.90560188796;4739.597134243559;4747.145513807513;4071.7760523171214;4074.449949256842;4076.3681629347498;4077.55146933837;4080.755154690728;6020.096985452174;6030.12563178341;6045.3047899491685;6058.4244496772735;6068.6662233577135;5336;5483.670979741229;5487.094629386146;5504.587155963279;5507.311586051744;6680.83297917556;6683.3650803174105;6686.498512611525;6686.565373250772;6699.39705426514;4511.120331535352;4511.661625378077;4512.210363186429;4513.819447222108;4517.435320584927;6780.220274668427;6890.276520965276;6919.411849992756;6936.34104760052;6967.825804354881;4597.517260687647;4610.239310513794;4610.907781844345;4613.677042606985;4618.214903466419;4657;4662.417197850269;4666.113438446684;4672.275797251432;4676.55572720591;5448.700321482277;5450.591205659592;5459.972700136474;5463.508284254436;5471.50756431923;6512.5766825156215;6680.265170831205;6704.631245281556;6737.8652426951185;6741.35957084086;1602.166873225916;1606.9598260043358;1649.4556796257207;1652.4381710218584;1653.4047742812577;1061.8407238914224;1071.5553045486192;1071.983920241197;1074.5272080284649;1077.49357801833;6390.105385246069;6412;6433.099366088752;6436.903446448307;6437.388448097423;6793.898091528631;6805.455563554904;6822.420094292041;6824.112865327575;6827.69275382609;6369.777057802955;6418.646974416359;6428.100065990765;6434.420902118738;6447.1296374989715;3798.9620103798607;3810.2189051244427;3820.4269359596283;3825.2731980923536;3828.1386687994977;7206.171290301578;7223.494355395072;7238.167610724729;7247.818804529929;7249.673764680602;6922.376986071277;7135.179454362815;7140.857182856314;7148.356647901714;7150.892736608955;7134.2509036551455;7173.820654483679;7196.244394338623;7217.6030318333;7241.2396698346965;6941.583504989717;6960.338767817049;6971;6980.301969802979;6983.615901125284;6721.22705888829;6855.828604284933;6906.274841141608;6914.308569143045;6916.3429474199875;7206.927930720835;7208.423326133792;7214.675339609835;7231.204567497676;7242.891356629761;4558.225101732647;4603.286490593963;4611.654125940635;4614.676972612019;4622;6826.078479405217;6948.513604047668;6956.2695916930015;6961.79114626562;6982.965085174542;6701.262861085374;6732.899006515004;6777.661116944231;6777.661116944231;6778.423833974168;6763.7632682855865;6771.28901465339;6773.796786096425;6775.186977562724;6781.728730850711;6495.772647957298;6631.734730610721;6636.303188165173;6645.3022432643875;6648.601083934979;6787.830304242236;6793.830154246183;6794.4904132189295;6795.830104247433;6804.795856124324;6592.17597800275;6592.241892182268;6613.570117942319;6620.735170593122;6624.105745724266 05:53:59 INFO - 2015-11-25 05:53:59,686 DEBUG : BROWSER_OUTPUT: |5;yui.html;752.2439947852407;755.7921571567819;837.1293854391433;858.1675774498734;872.2280781508363;12877.291748953803;13138.540151094714;13301.334933253323;13324;13327.466901323935;12752.426140823662;12862.163959342659;12887;12903.483860645587;13207.6698082548;816.0411516468156;824.9546274954876;827.8675411934091;830.4892491117979;831.8419500294955;821.3757544266371;823.9258466737992;833.6498670558381;839.0225387423644;839.2069494327862;868.8696695495663;873.5457562067753;874.470945078228;875.8861348024748;879.0462348352046;863.2575984653193;869.3523325122824;873.10506730601;873.6592728835727;876.3208513402101;639.3829954094275;639.68015992004;639.9296077431479;640.993590064098;641.5893827950116;13641.931790341085;13695.589132326046;13838.100523465942;13855.445782168701;13888.375023123883;11712.53149874004;11995.400229988552;12085.274883507018;12422.130450868442;12890.162139461;9891.752706182331;10251.436171010591;10336.121429678486;10475.63335283269;10553.208509361828;3579.928401431957;3658.4512323151475;3661.377565813818;3687.1519550503267;3705.7220708446976;43007.78496107499;43339.349909751065;45541.54458455406;46101.30848037282;46107.53892461066;9986.450745209084;10531.631392901212;10574.841377379345;10576.788464230673;10647.14822814173;17975.55061123456;18116.275348986157;18130.45608631743;18170.18234179465;18260.26958921628;7369.926300736924;7461.85076298471;7577.318041376303;7705.537667739954;7772.7668169954995;4203.747775133502;4294.240910490332;4300.462442194726;4326.891827704332;4506.143832671782;2950.808197467201;2992.9102126936227;2993.3115383461927;3005.1735772662255;3007.3985202959498;535.713393334572;537.543088374886;547.0481362429424;550.2681433693178;564.8841987392575;505.27997603414985;531.8909623527168;584.9824505264849;699.2552931128332;718.8741970155306;8628.827423451496;8649.178328058824;8743.475391476532;8820.691275805317;8823.382363234512;551.5146670929637;557.239368262319;647.6567419267795;705.1256442011868;709.0959027240207;3759.285735710206;3786.3563194257044;4054.688827368431;4249.40508328828;4378.78106094694;55300;57546;57718;57933.710331448914;58642.706786465795;49910.50089499058;50427.747861261196;50621;51735.74132129315;52070.21894671583;43315;46419;46475.30287045697;46527;47443;8588.141185881363;8667.956660216658;8736.956315218384;8769.868451973098;8798.560071996502;34310.48534272038;34999.82500087585;35406.645933540334;36185.27629447449;36201.45697814588;41275.793621032906;41490.58509414867;44406.77796610996;45018.549814502745;45532.77233613811;10338.12125969301;10512.947435262775;10749.086327661924;10903.12774977984;11127.499262533367;11135.83296250573;11459.569418545663;11688.357140357362;12035.699107522381;12457.06572007085;10895.346279223271;11422.200445968703;11701.941490292495;11718.179727419;12313.692157696129;10162.288639795439;10299.948500257451;10309.793804123725;10726.463676815973;11044.226904116957;11091.389973551532;11204.887951120385;11212.878712128722;11381.601643942422;11608.589048220656;8277.535613175914;8683.522406267715;8711.956440218011;8815.735527934172;9170.541472926461;8599.699010534601;9249.213816825646;9282.953585232031;9283.48940808262;9297.163255307054 05:53:59 INFO - 2015-11-25 05:53:59,687 DEBUG : BROWSER_OUTPUT: __end_tp_report 05:53:59 INFO - 2015-11-25 05:53:59,687 DEBUG : BROWSER_OUTPUT: __start_cc_report 05:53:59 INFO - 2015-11-25 05:53:59,687 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,295 05:53:59 INFO - 2015-11-25 05:53:59,687 DEBUG : BROWSER_OUTPUT: __end_cc_report 05:53:59 INFO - 2015-11-25 05:53:59,687 DEBUG : BROWSER_OUTPUT: __startTimestamp1448459639674__endTimestamp 05:53:59 INFO - 2015-11-25 05:53:59,687 DEBUG : BROWSER_OUTPUT: 05:53:59 INFO - 2015-11-25 05:53:59,687 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 05:53:59 INFO - 2015-11-25 05:53:59,687 DEBUG : BROWSER_OUTPUT: Number of tests: 6 05:53:59 INFO - 2015-11-25 05:53:59,688 DEBUG : BROWSER_OUTPUT: 05:53:59 INFO - 2015-11-25 05:53:59,688 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:5513.51 Median:5707.14 stddev:614.78 (10.8%) stddev-sans-first:589.27 05:53:59 INFO - 2015-11-25 05:53:59,689 DEBUG : BROWSER_OUTPUT: Values: 3199.9 3262.9 3287.5 3298.4 3309.7 5293.9 5434.3 5456.6 5474.6 5489.9 5375.9 5397.3 5441.6 5574.8 5601.8 5042.0 5096.9 5145.7 5166.0 5171.9 5021.2 5055.4 5103.4 5150.1 5165.2 4870.4 4944.8 4978.4 5016.7 5063.1 5012.5 5029.3 5049.9 5058.0 5084.6 5010.8 5015.8 5047.8 5051.4 5055.6 5138.1 5244.7 5262.4 5332.2 5352.0 5959.2 6016.9 6023.8 6026.7 6042.7 5726.1 6014.3 6021.1 6026.2 6031.9 5489.9 5567.9 5631.7 5635.3 5672.8 6088.9 6090.1 6090.3 6104.1 6106.1 5614.4 5707.1 5885.7 5887.0 5893.3 5871.8 5912.4 5916.3 5922.6 5929.6 5824.1 5877.8 5916.4 5919.8 5929.5 5722.3 5777.1 5823.9 5915.7 5926.4 4612.5 4619.1 4619.5 4621.6 4630.8 4123.7 4126.4 4135.0 4138.0 4164.2 5503.1 5581.1 5632.8 5730.8 5753.0 5914.0 5961.9 5986.2 6010.7 6012.9 5649.9 5676.3 5691.7 5692.7 5702.8 4931.1 5066.7 5105.1 5133.7 5189.6 6108.4 6197.3 6199.9 6200.0 6202.2 6003.0 6006.9 6015.3 6031.3 6042.7 5797.6 5969.6 5988.8 6099.7 6128.4 5911.2 5912.9 5939.5 5944.5 5947.4 5804.1 5998.4 6014.2 6044.2 6048.2 5690.7 5774.9 5862.0 5870.0 5921.6 5833.6 5869.8 5872.9 5884.1 5902.3 5554.0 5669.9 5762.3 5781.5 5783.0 5716.3 5812.2 5812.9 5814.9 5824.0 5627.9 5628.5 5654.1 5678.9 5679.7 05:53:59 INFO - 2015-11-25 05:53:59,689 DEBUG : BROWSER_OUTPUT: 05:53:59 INFO - 2015-11-25 05:53:59,689 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:44970.35 Median:35267.56 stddev:72872.48 (206.6%) stddev-sans-first:73000.69 05:53:59 INFO - 2015-11-25 05:53:59,691 DEBUG : BROWSER_OUTPUT: Values: 580.1 586.6 591.9 592.7 594.1 32242.0 40705.8 40830.0 41044.6 41125.0 42643.6 43110.0 43148.0 43302.4 43310.4 8497.6 8735.6 8756.3 8762.9 8804.6 8501.7 8632.6 8635.9 8649.4 8656.0 8581.7 8659.9 8660.1 8734.9 8735.3 8614.7 8677.0 8707.2 8716.1 8719.4 8508.2 8656.9 8682.5 8698.5 8726.7 41091.6 41415.6 41591.0 41676.4 41714.2 3249.8 3294.7 3311.8 3325.1 3367.2 29854.6 30229.0 30437.8 30745.7 31430.8 3646.3 3666.9 3711.9 3753.0 3832.8 268978.0 269382.0 271220.0 271765.0 272546.0 53213.0 53906.2 59204.7 59578.1 67846.3 63606.4 63809.0 63847.4 63902.7 64158.0 15395.2 15556.5 15602.4 15624.6 15638.7 10507.3 10538.2 10579.1 10594.9 10597.4 20236.3 20575.6 20687.9 20903.8 20934.9 7340.6 7377.6 7472.6 7520.6 7587.1 895.5 983.6 1047.1 1053.6 1078.4 28128.4 28373.0 28877.9 28951.6 28988.9 1090.7 1112.2 1112.7 1130.0 1172.1 13761.9 14267.2 14294.7 14346.8 14609.6 326152.0 330427.0 331247.0 331354.0 331943.0 52090.2 52147.0 52563.2 52585.5 52615.2 1286.1 1320.3 1335.2 1337.2 1352.4 26934.7 27915.3 28070.9 28335.3 29153.9 44382.8 44434.1 44881.3 44945.1 45102.8 224321.0 225533.0 225645.0 225808.0 226076.0 31203.8 31339.4 31743.5 31848.7 32183.5 39648.2 41908.0 42518.6 43291.8 43593.8 35063.6 36046.6 36153.8 36357.1 36630.0 33169.5 33801.3 33809.0 33999.0 36672.8 34675.0 35127.5 35407.6 35515.0 35570.3 31832.8 32539.0 32615.8 32875.7 33250.5 25297.6 26798.6 26915.0 26958.0 27033.9 05:53:59 INFO - 2015-11-25 05:53:59,691 DEBUG : BROWSER_OUTPUT: 05:53:59 INFO - 2015-11-25 05:53:59,691 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:29081.57 Median:4377.45 stddev:88937.06 (2031.7%) stddev-sans-first:89160.39 05:53:59 INFO - 2015-11-25 05:53:59,691 DEBUG : BROWSER_OUTPUT: Values: 351.1 353.6 358.1 358.4 359.0 16623.8 17232.4 17604.0 18151.1 18200.5 14626.3 14848.0 15061.4 15161.4 15234.7 4779.5 4927.5 4966.3 4974.5 4980.4 4975.2 5020.1 5025.3 5025.7 5030.0 4867.4 4954.6 5047.5 5174.2 5204.5 5079.5 5096.0 5112.9 5113.5 5235.3 5217.3 5230.4 5237.5 5255.4 5260.0 12453.0 15364.8 18962.4 19877.3 19933.6 2040.0 2075.2 2120.9 2135.5 2145.5 9782.6 9995.6 11246.9 12950.2 13436.7 1759.6 1896.3 1896.7 1896.8 1899.4 62689.7 64529.7 64968.4 65101.0 66197.0 9413.0 9509.4 9636.5 9637.5 9665.3 12402.9 12459.4 12558.4 12575.4 12622.6 7053.9 7137.8 7147.7 7166.9 7483.9 6738.8 6847.0 6878.1 6905.3 6978.1 4290.9 4339.5 4366.2 4388.7 4458.1 1801.3 1811.1 1821.9 1865.6 1880.6 909.3 966.2 968.9 976.7 983.5 14913.0 15976.9 17212.3 17665.9 18158.5 936.3 941.1 943.4 965.3 967.1 9553.3 9653.7 9804.2 9847.4 9897.8 532463.0 536997.0 546174.0 549407.0 554420.0 78078.0 78843.6 79782.0 80204.0 80552.0 1145.7 1153.9 1160.6 1163.7 1164.5 15166.6 15181.7 15263.0 15286.0 15479.5 34867.0 35068.3 35267.8 35510.0 36713.6 48791.8 48841.3 50532.2 51732.0 52083.0 9453.3 9578.5 9585.2 9678.1 9680.7 15717.2 16594.8 16708.2 16925.4 16958.7 13635.3 13968.1 14150.6 14399.0 14632.3 14409.6 14437.4 14569.0 15014.3 15107.2 14942.6 15139.2 15170.2 15473.0 15570.4 9311.7 9576.4 9579.6 9649.5 9835.4 14628.6 14672.6 14841.6 14862.5 14982.7 05:53:59 INFO - 2015-11-25 05:53:59,692 DEBUG : BROWSER_OUTPUT: 05:53:59 INFO - 2015-11-25 05:53:59,692 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5146.62 Median:6496.08 stddev:2619.49 (40.3%) stddev-sans-first:2612.43 05:53:59 INFO - 2015-11-25 05:53:59,692 DEBUG : BROWSER_OUTPUT: Values: 1492.0 1697.4 1714.5 1728.3 1765.2 7044.4 7141.5 7348.9 7491.6 7492.7 7107.1 7194.4 7214.3 7221.9 7231.0 1996.3 2039.4 2042.6 2042.9 2044.9 2170.9 2226.0 2246.9 2247.4 2253.4 2186.2 2200.1 2215.3 2223.6 2226.7 2070.3 2096.4 2097.4 2097.6 2099.0 2181.5 2248.7 2275.9 2280.1 2280.9 7241.6 7336.9 7341.0 7379.6 7385.3 4320.5 4375.2 4375.8 4376.2 4389.8 2930.9 2941.8 2984.8 2987.1 3005.9 903.6 914.9 918.0 975.2 979.2 9776.5 9835.6 9885.2 9927.1 9949.2 4043.8 4048.2 4112.8 4114.7 4128.9 8546.7 8567.5 8568.9 8575.1 8578.5 4440.3 4447.2 4452.2 4485.6 4487.2 3938.3 4046.3 4073.8 4113.7 4129.0 3430.9 3469.3 3475.3 3504.2 3505.0 1083.5 1102.2 1105.8 1110.4 1115.7 947.1 960.5 966.3 1059.9 1353.5 6717.2 6730.0 6744.2 6777.9 6826.9 457.3 1172.4 1191.9 1195.2 1207.4 5509.2 5515.7 5568.7 5577.7 5615.5 8291.3 8389.7 8606.1 8639.7 8648.2 8616.5 8631.0 8653.9 8704.9 8739.6 6903.3 6910.8 6937.0 6965.4 6966.3 6473.0 6519.2 6524.5 6567.6 6590.3 7642.2 7751.8 7845.6 7918.3 7993.1 7862.1 8077.6 8107.3 8169.4 8170.5 6331.9 6335.1 6385.1 6597.3 6641.1 7147.0 7167.8 7187.3 7192.5 7203.7 6621.9 6739.7 6758.4 6787.8 6909.7 6589.7 6661.9 6716.0 6735.8 6746.9 6624.3 6637.3 6684.4 6694.4 6699.7 5988.0 5998.1 6060.3 6064.7 6069.5 6186.1 6251.7 6279.3 6279.7 6293.6 05:53:59 INFO - 2015-11-25 05:53:59,692 DEBUG : BROWSER_OUTPUT: 05:53:59 INFO - 2015-11-25 05:53:59,692 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:5582.84 Median:6401.05 stddev:1722.27 (26.9%) stddev-sans-first:1680.86 05:53:59 INFO - 2015-11-25 05:53:59,693 DEBUG : BROWSER_OUTPUT: Values: 301.2 309.9 320.7 322.4 323.9 6178.4 6277.4 6333.8 6388.7 6481.4 6284.6 6331.2 6355.2 6356.6 6362.4 4800.2 4804.4 4805.9 4809.2 4818.7 4791.9 4799.6 4805.9 4806.0 4808.7 4662.8 4743.9 4748.4 4748.8 4749.0 4717.0 4718.7 4719.9 4739.6 4747.1 4071.8 4074.4 4076.4 4077.6 4080.8 6020.1 6030.1 6045.3 6058.4 6068.7 5336.0 5483.7 5487.1 5504.6 5507.3 6680.8 6683.4 6686.5 6686.6 6699.4 4511.1 4511.7 4512.2 4513.8 4517.4 6780.2 6890.3 6919.4 6936.3 6967.8 4597.5 4610.2 4610.9 4613.7 4618.2 4657.0 4662.4 4666.1 4672.3 4676.6 5448.7 5450.6 5460.0 5463.5 5471.5 6512.6 6680.3 6704.6 6737.9 6741.4 1602.2 1607.0 1649.5 1652.4 1653.4 1061.8 1071.6 1072.0 1074.5 1077.5 6390.1 6412.0 6433.1 6436.9 6437.4 6793.9 6805.5 6822.4 6824.1 6827.7 6369.8 6418.6 6428.1 6434.4 6447.1 3799.0 3810.2 3820.4 3825.3 3828.1 7206.2 7223.5 7238.2 7247.8 7249.7 6922.4 7135.2 7140.9 7148.4 7150.9 7134.3 7173.8 7196.2 7217.6 7241.2 6941.6 6960.3 6971.0 6980.3 6983.6 6721.2 6855.8 6906.3 6914.3 6916.3 7206.9 7208.4 7214.7 7231.2 7242.9 4558.2 4603.3 4611.7 4614.7 4622.0 6826.1 6948.5 6956.3 6961.8 6983.0 6701.3 6732.9 6777.7 6777.7 6778.4 6763.8 6771.3 6773.8 6775.2 6781.7 6495.8 6631.7 6636.3 6645.3 6648.6 6787.8 6793.8 6794.5 6795.8 6804.8 6592.2 6592.2 6613.6 6620.7 6624.1 05:53:59 INFO - 2015-11-25 05:53:59,693 DEBUG : BROWSER_OUTPUT: 05:53:59 INFO - 2015-11-25 05:53:59,694 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:13602.35 Median:45537.16 stddev:15683.49 (34.4%) stddev-sans-first:15697.80 05:53:59 INFO - 2015-11-25 05:53:59,694 DEBUG : BROWSER_OUTPUT: Values: 752.2 755.8 837.1 858.2 872.2 12877.3 13138.5 13301.3 13324.0 13327.5 12752.4 12862.2 12887.0 12903.5 13207.7 816.0 825.0 827.9 830.5 831.8 821.4 823.9 833.6 839.0 839.2 868.9 873.5 874.5 875.9 879.0 863.3 869.4 873.1 873.7 876.3 639.4 639.7 639.9 641.0 641.6 13641.9 13695.6 13838.1 13855.4 13888.4 11712.5 11995.4 12085.3 12422.1 12890.2 9891.8 10251.4 10336.1 10475.6 10553.2 3579.9 3658.5 3661.4 3687.2 3705.7 43007.8 43339.3 45541.5 46101.3 46107.5 9986.5 10531.6 10574.8 10576.8 10647.1 17975.6 18116.3 18130.5 18170.2 18260.3 7369.9 7461.9 7577.3 7705.5 7772.8 4203.7 4294.2 4300.5 4326.9 4506.1 2950.8 2992.9 2993.3 3005.2 3007.4 535.7 537.5 547.0 550.3 564.9 505.3 531.9 585.0 699.3 718.9 8628.8 8649.2 8743.5 8820.7 8823.4 551.5 557.2 647.7 705.1 709.1 3759.3 3786.4 4054.7 4249.4 4378.8 55300.0 57546.0 57718.0 57933.7 58642.7 49910.5 50427.7 50621.0 51735.7 52070.2 43315.0 46419.0 46475.3 46527.0 47443.0 8588.1 8668.0 8737.0 8769.9 8798.6 34310.5 34999.8 35406.6 36185.3 36201.5 41275.8 41490.6 44406.8 45018.5 45532.8 10338.1 10512.9 10749.1 10903.1 11127.5 11135.8 11459.6 11688.4 12035.7 12457.1 10895.3 11422.2 11701.9 11718.2 12313.7 10162.3 10299.9 10309.8 10726.5 11044.2 11091.4 11204.9 11212.9 11381.6 11608.6 8277.5 8683.5 8712.0 8815.7 9170.5 8599.7 9249.2 9283.0 9283.5 9297.2 05:53:59 INFO - 2015-11-25 05:53:59,694 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 05:53:59 INFO - 2015-11-25 05:53:59,694 DEBUG : BROWSER_OUTPUT: 05:54:00 INFO - 2015-11-25 05:54:00,398 INFO : Browser exited with error code: 0 05:54:00 INFO - 2015-11-25 05:54:00,415 INFO : Completed test dromaeo_css (00:18:33) 05:54:00 INFO - 2015-11-25 05:54:00,415 INFO : Starting test kraken 05:54:00 INFO - 2015-11-25 05:54:00,415 DEBUG : operating with platform_type : linux_ 05:54:00 INFO - 2015-11-25 05:54:00,415 INFO : Initialising browser for kraken test... 05:54:00 INFO - 2015-11-25 05:54:00,421 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpWM6c9R/profile http://localhost:57653/getInfo.html 05:54:04 INFO - 2015-11-25 05:54:04,920 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 05:54:04 INFO - 2015-11-25 05:54:04,920 DEBUG : BROWSER_OUTPUT: colorDepth:24 05:54:04 INFO - 2015-11-25 05:54:04,920 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/668 05:54:04 INFO - 2015-11-25 05:54:04,920 DEBUG : BROWSER_OUTPUT: __metrics 05:54:05 INFO - 2015-11-25 05:54:05,946 INFO : Browser initialized. 05:54:05 INFO - 2015-11-25 05:54:05,947 INFO : Running cycle 1/1 for kraken test... 05:54:05 INFO - 2015-11-25 05:54:05,947 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpWM6c9R/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 05:54:17 INFO - 2015-11-25 05:54:17,662 DEBUG : BROWSER_OUTPUT: RSS: Main: 140664832 05:54:17 INFO - 2015-11-25 05:54:17,662 DEBUG : BROWSER_OUTPUT: 05:54:20 INFO - 2015-11-25 05:54:20,230 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57653/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:57653/tests/kraken/driver.html?testName=audio-beat-detection) 05:54:20 INFO - 2015-11-25 05:54:20,837 DEBUG : BROWSER_OUTPUT: RSS: Main: 140705792 05:54:20 INFO - 2015-11-25 05:54:20,837 DEBUG : BROWSER_OUTPUT: 05:54:23 INFO - 2015-11-25 05:54:23,477 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57653/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:57653/tests/kraken/driver.html?testName=audio-dft) 05:54:24 INFO - 2015-11-25 05:54:24,083 DEBUG : BROWSER_OUTPUT: RSS: Main: 139665408 05:54:24 INFO - 2015-11-25 05:54:24,084 DEBUG : BROWSER_OUTPUT: 05:54:26 INFO - 2015-11-25 05:54:26,944 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57653/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:57653/tests/kraken/driver.html?testName=audio-fft) 05:54:27 INFO - 2015-11-25 05:54:27,526 DEBUG : BROWSER_OUTPUT: RSS: Main: 136327168 05:54:27 INFO - 2015-11-25 05:54:27,526 DEBUG : BROWSER_OUTPUT: 05:54:29 INFO - 2015-11-25 05:54:29,725 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57653/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:57653/tests/kraken/driver.html?testName=audio-oscillator) 05:54:30 INFO - 2015-11-25 05:54:30,351 DEBUG : BROWSER_OUTPUT: RSS: Main: 134733824 05:54:30 INFO - 2015-11-25 05:54:30,351 DEBUG : BROWSER_OUTPUT: 05:54:32 INFO - 2015-11-25 05:54:32,584 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57653/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:57653/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:54:33 INFO - 2015-11-25 05:54:33,165 DEBUG : BROWSER_OUTPUT: RSS: Main: 136929280 05:54:33 INFO - 2015-11-25 05:54:33,165 DEBUG : BROWSER_OUTPUT: 05:54:36 INFO - 2015-11-25 05:54:36,184 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57653/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:57653/tests/kraken/driver.html?testName=imaging-darkroom) 05:54:36 INFO - 2015-11-25 05:54:36,771 DEBUG : BROWSER_OUTPUT: RSS: Main: 137867264 05:54:36 INFO - 2015-11-25 05:54:36,771 DEBUG : BROWSER_OUTPUT: 05:54:40 INFO - 2015-11-25 05:54:40,194 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57653/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:57653/tests/kraken/driver.html?testName=imaging-desaturate) 05:54:40 INFO - 2015-11-25 05:54:40,780 DEBUG : BROWSER_OUTPUT: RSS: Main: 138158080 05:54:40 INFO - 2015-11-25 05:54:40,780 DEBUG : BROWSER_OUTPUT: 05:54:43 INFO - 2015-11-25 05:54:43,619 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57653/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:57653/tests/kraken/driver.html?testName=json-parse-financial) 05:54:44 INFO - 2015-11-25 05:54:44,212 DEBUG : BROWSER_OUTPUT: RSS: Main: 138551296 05:54:44 INFO - 2015-11-25 05:54:44,212 DEBUG : BROWSER_OUTPUT: 05:54:45 INFO - 2015-11-25 05:54:45,821 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57653/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:57653/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:54:46 INFO - 2015-11-25 05:54:46,391 DEBUG : BROWSER_OUTPUT: RSS: Main: 139046912 05:54:46 INFO - 2015-11-25 05:54:46,391 DEBUG : BROWSER_OUTPUT: 05:54:48 INFO - 2015-11-25 05:54:48,242 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57653/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:57653/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:54:48 INFO - 2015-11-25 05:54:48,863 DEBUG : BROWSER_OUTPUT: RSS: Main: 138092544 05:54:48 INFO - 2015-11-25 05:54:48,863 DEBUG : BROWSER_OUTPUT: 05:54:50 INFO - 2015-11-25 05:54:50,944 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57653/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:57653/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:54:51 INFO - 2015-11-25 05:54:51,533 DEBUG : BROWSER_OUTPUT: RSS: Main: 138309632 05:54:51 INFO - 2015-11-25 05:54:51,533 DEBUG : BROWSER_OUTPUT: 05:54:54 INFO - 2015-11-25 05:54:54,027 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57653/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:57653/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:54:54 INFO - 2015-11-25 05:54:54,622 DEBUG : BROWSER_OUTPUT: RSS: Main: 138727424 05:54:54 INFO - 2015-11-25 05:54:54,622 DEBUG : BROWSER_OUTPUT: 05:54:57 INFO - 2015-11-25 05:54:57,217 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57653/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:57653/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:54:57 INFO - 2015-11-25 05:54:57,790 DEBUG : BROWSER_OUTPUT: RSS: Main: 138399744 05:54:57 INFO - 2015-11-25 05:54:57,791 DEBUG : BROWSER_OUTPUT: 05:54:59 INFO - 2015-11-25 05:54:59,486 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57653/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:57653/tests/kraken/driver.html?testName=ai-astar) 05:54:59 INFO - 2015-11-25 05:54:59,736 DEBUG : BROWSER_OUTPUT: RSS: Main: 137740288 05:54:59 INFO - 2015-11-25 05:54:59,736 DEBUG : BROWSER_OUTPUT: 05:54:59 INFO - 2015-11-25 05:54:59,738 DEBUG : BROWSER_OUTPUT: __start_tp_report 05:54:59 INFO - 2015-11-25 05:54:59,738 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 05:54:59 INFO - 2015-11-25 05:54:59,738 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 05:54:59 INFO - 2015-11-25 05:54:59,738 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 05:54:59 INFO - 2015-11-25 05:54:59,739 DEBUG : BROWSER_OUTPUT: |0;ai-astar;112;106;113;112;111;125;113;113;110;111 05:54:59 INFO - 2015-11-25 05:54:59,739 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;155;126;162;163;128;152;161;131;160;126 05:54:59 INFO - 2015-11-25 05:54:59,739 DEBUG : BROWSER_OUTPUT: |2;audio-dft;162;163;164;164;163;161;161;164;175;163 05:54:59 INFO - 2015-11-25 05:54:59,739 DEBUG : BROWSER_OUTPUT: |3;audio-fft;72;72;71;71;72;74;139;89;71;71 05:54:59 INFO - 2015-11-25 05:54:59,739 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;92;94;134;93;94;93;142;95;93;141 05:54:59 INFO - 2015-11-25 05:54:59,739 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;110;110;109;109;111;112;110;110;110;111 05:54:59 INFO - 2015-11-25 05:54:59,740 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;147;146;146;147;147;146;146;147;147;147 05:54:59 INFO - 2015-11-25 05:54:59,740 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;97;98;97;97;96;95;96;97;96;97 05:54:59 INFO - 2015-11-25 05:54:59,740 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;61;61;63;61;61;61;61;61;60;58 05:54:59 INFO - 2015-11-25 05:54:59,740 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;70;71;71;70;71;70;71;71;75;70 05:54:59 INFO - 2015-11-25 05:54:59,740 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;85;87;87;86;87;86;87;86;95;86 05:54:59 INFO - 2015-11-25 05:54:59,740 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;115;138;123;117;119;130;136;119;127;120 05:54:59 INFO - 2015-11-25 05:54:59,741 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;152;150;150;150;150;149;148;150;141;153 05:54:59 INFO - 2015-11-25 05:54:59,741 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;69;66;66;69;66;78;69;67;66;70 05:54:59 INFO - 2015-11-25 05:54:59,741 DEBUG : BROWSER_OUTPUT: __end_tp_report 05:54:59 INFO - 2015-11-25 05:54:59,741 DEBUG : BROWSER_OUTPUT: __start_cc_report 05:54:59 INFO - 2015-11-25 05:54:59,741 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,735 05:54:59 INFO - 2015-11-25 05:54:59,741 DEBUG : BROWSER_OUTPUT: __end_cc_report 05:54:59 INFO - 2015-11-25 05:54:59,741 DEBUG : BROWSER_OUTPUT: __startTimestamp1448459699737__endTimestamp 05:54:59 INFO - 2015-11-25 05:54:59,741 DEBUG : BROWSER_OUTPUT: 05:54:59 INFO - 2015-11-25 05:54:59,745 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 05:54:59 INFO - 2015-11-25 05:54:59,745 DEBUG : BROWSER_OUTPUT: Number of tests: 14 05:54:59 INFO - 2015-11-25 05:54:59,745 DEBUG : BROWSER_OUTPUT: 05:54:59 INFO - 2015-11-25 05:54:59,745 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:112.60 Median:112.50 stddev:4.84 (4.3%) stddev-sans-first:5.12 05:54:59 INFO - 2015-11-25 05:54:59,745 DEBUG : BROWSER_OUTPUT: Values: 112.0 106.0 113.0 112.0 111.0 125.0 113.0 113.0 110.0 111.0 05:54:59 INFO - 2015-11-25 05:54:59,746 DEBUG : BROWSER_OUTPUT: 05:54:59 INFO - 2015-11-25 05:54:59,746 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:146.40 Median:157.50 stddev:16.43 (10.4%) stddev-sans-first:17.13 05:54:59 INFO - 2015-11-25 05:54:59,746 DEBUG : BROWSER_OUTPUT: Values: 155.0 126.0 162.0 163.0 128.0 152.0 161.0 131.0 160.0 126.0 05:54:59 INFO - 2015-11-25 05:54:59,746 DEBUG : BROWSER_OUTPUT: 05:54:59 INFO - 2015-11-25 05:54:59,746 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:164.00 Median:163.50 stddev:4.03 (2.5%) stddev-sans-first:4.21 05:54:59 INFO - 2015-11-25 05:54:59,746 DEBUG : BROWSER_OUTPUT: Values: 162.0 163.0 164.0 164.0 163.0 161.0 161.0 164.0 175.0 163.0 05:54:59 INFO - 2015-11-25 05:54:59,746 DEBUG : BROWSER_OUTPUT: 05:54:59 INFO - 2015-11-25 05:54:59,746 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:80.20 Median:72.00 stddev:21.38 (29.7%) stddev-sans-first:22.47 05:54:59 INFO - 2015-11-25 05:54:59,746 DEBUG : BROWSER_OUTPUT: Values: 72.0 72.0 71.0 71.0 72.0 74.0 139.0 89.0 71.0 71.0 05:54:59 INFO - 2015-11-25 05:54:59,746 DEBUG : BROWSER_OUTPUT: 05:54:59 INFO - 2015-11-25 05:54:59,748 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:107.10 Median:93.00 stddev:22.12 (23.8%) stddev-sans-first:22.78 05:54:59 INFO - 2015-11-25 05:54:59,748 DEBUG : BROWSER_OUTPUT: Values: 92.0 94.0 134.0 93.0 94.0 93.0 142.0 95.0 93.0 141.0 05:54:59 INFO - 2015-11-25 05:54:59,748 DEBUG : BROWSER_OUTPUT: 05:54:59 INFO - 2015-11-25 05:54:59,748 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:110.20 Median:110.00 stddev:0.92 (0.8%) stddev-sans-first:0.97 05:54:59 INFO - 2015-11-25 05:54:59,748 DEBUG : BROWSER_OUTPUT: Values: 110.0 110.0 109.0 109.0 111.0 112.0 110.0 110.0 110.0 111.0 05:54:59 INFO - 2015-11-25 05:54:59,748 DEBUG : BROWSER_OUTPUT: 05:54:59 INFO - 2015-11-25 05:54:59,748 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:146.60 Median:147.00 stddev:0.52 (0.4%) stddev-sans-first:0.53 05:54:59 INFO - 2015-11-25 05:54:59,748 DEBUG : BROWSER_OUTPUT: Values: 147.0 146.0 146.0 147.0 147.0 146.0 146.0 147.0 147.0 147.0 05:54:59 INFO - 2015-11-25 05:54:59,748 DEBUG : BROWSER_OUTPUT: 05:54:59 INFO - 2015-11-25 05:54:59,748 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:96.60 Median:97.00 stddev:0.84 (0.9%) stddev-sans-first:0.88 05:54:59 INFO - 2015-11-25 05:54:59,748 DEBUG : BROWSER_OUTPUT: Values: 97.0 98.0 97.0 97.0 96.0 95.0 96.0 97.0 96.0 97.0 05:54:59 INFO - 2015-11-25 05:54:59,748 DEBUG : BROWSER_OUTPUT: 05:54:59 INFO - 2015-11-25 05:54:59,748 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:60.80 Median:61.00 stddev:1.23 (2.0%) stddev-sans-first:1.30 05:54:59 INFO - 2015-11-25 05:54:59,748 DEBUG : BROWSER_OUTPUT: Values: 61.0 61.0 63.0 61.0 61.0 61.0 61.0 61.0 60.0 58.0 05:54:59 INFO - 2015-11-25 05:54:59,749 DEBUG : BROWSER_OUTPUT: 05:54:59 INFO - 2015-11-25 05:54:59,749 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:71.00 Median:71.00 stddev:1.49 (2.1%) stddev-sans-first:1.54 05:54:59 INFO - 2015-11-25 05:54:59,749 DEBUG : BROWSER_OUTPUT: Values: 70.0 71.0 71.0 70.0 71.0 70.0 71.0 71.0 75.0 70.0 05:54:59 INFO - 2015-11-25 05:54:59,749 DEBUG : BROWSER_OUTPUT: 05:54:59 INFO - 2015-11-25 05:54:59,749 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:87.20 Median:87.00 stddev:2.82 (3.2%) stddev-sans-first:2.88 05:54:59 INFO - 2015-11-25 05:54:59,749 DEBUG : BROWSER_OUTPUT: Values: 85.0 87.0 87.0 86.0 87.0 86.0 87.0 86.0 95.0 86.0 05:54:59 INFO - 2015-11-25 05:54:59,749 DEBUG : BROWSER_OUTPUT: 05:54:59 INFO - 2015-11-25 05:54:59,749 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:124.40 Median:125.00 stddev:8.03 (6.4%) stddev-sans-first:7.76 05:54:59 INFO - 2015-11-25 05:54:59,749 DEBUG : BROWSER_OUTPUT: Values: 115.0 138.0 123.0 117.0 119.0 130.0 136.0 119.0 127.0 120.0 05:54:59 INFO - 2015-11-25 05:54:59,749 DEBUG : BROWSER_OUTPUT: 05:54:59 INFO - 2015-11-25 05:54:59,749 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:149.30 Median:150.00 stddev:3.23 (2.2%) stddev-sans-first:3.28 05:54:59 INFO - 2015-11-25 05:54:59,749 DEBUG : BROWSER_OUTPUT: Values: 152.0 150.0 150.0 150.0 150.0 149.0 148.0 150.0 141.0 153.0 05:54:59 INFO - 2015-11-25 05:54:59,749 DEBUG : BROWSER_OUTPUT: 05:54:59 INFO - 2015-11-25 05:54:59,749 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.60 Median:69.00 stddev:3.66 (5.3%) stddev-sans-first:3.88 05:54:59 INFO - 2015-11-25 05:54:59,749 DEBUG : BROWSER_OUTPUT: Values: 69.0 66.0 66.0 69.0 66.0 78.0 69.0 67.0 66.0 70.0 05:54:59 INFO - 2015-11-25 05:54:59,750 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 05:54:59 INFO - 2015-11-25 05:54:59,750 DEBUG : BROWSER_OUTPUT: 05:55:00 INFO - 2015-11-25 05:55:00,570 INFO : Browser exited with error code: 0 05:55:00 INFO - 2015-11-25 05:55:00,621 INFO : Completed test kraken (00:01:00) 05:55:00 INFO - 2015-11-25 05:55:00,621 INFO : Starting test v8_7 05:55:00 INFO - 2015-11-25 05:55:00,621 DEBUG : operating with platform_type : linux_ 05:55:00 INFO - 2015-11-25 05:55:00,621 INFO : Initialising browser for v8_7 test... 05:55:00 INFO - 2015-11-25 05:55:00,627 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpDot1i6/profile http://localhost:57653/getInfo.html 05:55:05 INFO - 2015-11-25 05:55:05,174 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 05:55:05 INFO - 2015-11-25 05:55:05,175 DEBUG : BROWSER_OUTPUT: colorDepth:24 05:55:05 INFO - 2015-11-25 05:55:05,175 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/668 05:55:05 INFO - 2015-11-25 05:55:05,175 DEBUG : BROWSER_OUTPUT: __metrics 05:55:06 INFO - 2015-11-25 05:55:06,222 INFO : Browser initialized. 05:55:06 INFO - 2015-11-25 05:55:06,223 INFO : Running cycle 1/1 for v8_7 test... 05:55:06 INFO - 2015-11-25 05:55:06,223 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpDot1i6/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 05:55:17 INFO - 2015-11-25 05:55:17,918 DEBUG : BROWSER_OUTPUT: RSS: Main: 140734464 05:55:17 INFO - 2015-11-25 05:55:17,919 DEBUG : BROWSER_OUTPUT: 05:55:39 INFO - 2015-11-25 05:55:39,376 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57653/tests/v8_7/run.html (next: http://localhost:57653/tests/v8_7/run.html) 05:55:39 INFO - 2015-11-25 05:55:39,634 DEBUG : BROWSER_OUTPUT: RSS: Main: 136826880 05:55:39 INFO - 2015-11-25 05:55:39,635 DEBUG : BROWSER_OUTPUT: 05:55:39 INFO - 2015-11-25 05:55:39,635 DEBUG : BROWSER_OUTPUT: __start_tp_report 05:55:39 INFO - 2015-11-25 05:55:39,635 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 05:55:39 INFO - 2015-11-25 05:55:39,635 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 05:55:39 INFO - 2015-11-25 05:55:39,635 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 05:55:39 INFO - 2015-11-25 05:55:39,635 DEBUG : BROWSER_OUTPUT: |0;Richards;166.5278934221482 05:55:39 INFO - 2015-11-25 05:55:39,635 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;191.57088122605364 05:55:39 INFO - 2015-11-25 05:55:39,636 DEBUG : BROWSER_OUTPUT: |2;Encrypt;279.79854504756577 05:55:39 INFO - 2015-11-25 05:55:39,636 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5164.948453608247 05:55:39 INFO - 2015-11-25 05:55:39,636 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1051.4705882352941 05:55:39 INFO - 2015-11-25 05:55:39,636 DEBUG : BROWSER_OUTPUT: |5;Earley;714.2857142857143 05:55:39 INFO - 2015-11-25 05:55:39,636 DEBUG : BROWSER_OUTPUT: |6;Boyer;12280.487804878048 05:55:39 INFO - 2015-11-25 05:55:39,636 DEBUG : BROWSER_OUTPUT: |7;RegExp;24902.439024390245 05:55:39 INFO - 2015-11-25 05:55:39,636 DEBUG : BROWSER_OUTPUT: |8;Splay;569.4760820045558 05:55:39 INFO - 2015-11-25 05:55:39,636 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4859.223300970873 05:55:39 INFO - 2015-11-25 05:55:39,637 DEBUG : BROWSER_OUTPUT: __end_tp_report 05:55:39 INFO - 2015-11-25 05:55:39,637 DEBUG : BROWSER_OUTPUT: __startTimestamp1448459739628__endTimestamp 05:55:39 INFO - 2015-11-25 05:55:39,637 DEBUG : BROWSER_OUTPUT: 05:55:39 INFO - 2015-11-25 05:55:39,637 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 05:55:39 INFO - 2015-11-25 05:55:39,637 DEBUG : BROWSER_OUTPUT: Number of tests: 10 05:55:39 INFO - 2015-11-25 05:55:39,638 DEBUG : BROWSER_OUTPUT: 05:55:39 INFO - 2015-11-25 05:55:39,638 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:166.53 Median:166.53 stddev:0.00 (0.0%) 05:55:39 INFO - 2015-11-25 05:55:39,638 DEBUG : BROWSER_OUTPUT: Values: 166.5 05:55:39 INFO - 2015-11-25 05:55:39,638 DEBUG : BROWSER_OUTPUT: 05:55:39 INFO - 2015-11-25 05:55:39,638 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:191.57 Median:191.57 stddev:0.00 (0.0%) 05:55:39 INFO - 2015-11-25 05:55:39,638 DEBUG : BROWSER_OUTPUT: Values: 191.6 05:55:39 INFO - 2015-11-25 05:55:39,639 DEBUG : BROWSER_OUTPUT: 05:55:39 INFO - 2015-11-25 05:55:39,639 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:279.80 Median:279.80 stddev:0.00 (0.0%) 05:55:39 INFO - 2015-11-25 05:55:39,639 DEBUG : BROWSER_OUTPUT: Values: 279.8 05:55:39 INFO - 2015-11-25 05:55:39,639 DEBUG : BROWSER_OUTPUT: 05:55:39 INFO - 2015-11-25 05:55:39,639 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5164.95 Median:5164.95 stddev:0.00 (0.0%) 05:55:39 INFO - 2015-11-25 05:55:39,639 DEBUG : BROWSER_OUTPUT: Values: 5164.9 05:55:39 INFO - 2015-11-25 05:55:39,639 DEBUG : BROWSER_OUTPUT: 05:55:39 INFO - 2015-11-25 05:55:39,639 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1051.47 Median:1051.47 stddev:0.00 (0.0%) 05:55:39 INFO - 2015-11-25 05:55:39,640 DEBUG : BROWSER_OUTPUT: Values: 1051.5 05:55:39 INFO - 2015-11-25 05:55:39,640 DEBUG : BROWSER_OUTPUT: 05:55:39 INFO - 2015-11-25 05:55:39,640 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:714.29 Median:714.29 stddev:0.00 (0.0%) 05:55:39 INFO - 2015-11-25 05:55:39,640 DEBUG : BROWSER_OUTPUT: Values: 714.3 05:55:39 INFO - 2015-11-25 05:55:39,640 DEBUG : BROWSER_OUTPUT: 05:55:39 INFO - 2015-11-25 05:55:39,640 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:12280.49 Median:12280.49 stddev:0.00 (0.0%) 05:55:39 INFO - 2015-11-25 05:55:39,640 DEBUG : BROWSER_OUTPUT: Values: 12280.5 05:55:39 INFO - 2015-11-25 05:55:39,641 DEBUG : BROWSER_OUTPUT: 05:55:39 INFO - 2015-11-25 05:55:39,641 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:24902.44 Median:24902.44 stddev:0.00 (0.0%) 05:55:39 INFO - 2015-11-25 05:55:39,641 DEBUG : BROWSER_OUTPUT: Values: 24902.4 05:55:39 INFO - 2015-11-25 05:55:39,641 DEBUG : BROWSER_OUTPUT: 05:55:39 INFO - 2015-11-25 05:55:39,641 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:569.48 Median:569.48 stddev:0.00 (0.0%) 05:55:39 INFO - 2015-11-25 05:55:39,641 DEBUG : BROWSER_OUTPUT: Values: 569.5 05:55:39 INFO - 2015-11-25 05:55:39,641 DEBUG : BROWSER_OUTPUT: 05:55:39 INFO - 2015-11-25 05:55:39,641 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4859.22 Median:4859.22 stddev:0.00 (0.0%) 05:55:39 INFO - 2015-11-25 05:55:39,642 DEBUG : BROWSER_OUTPUT: Values: 4859.2 05:55:39 INFO - 2015-11-25 05:55:39,642 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 05:55:39 INFO - 2015-11-25 05:55:39,642 DEBUG : BROWSER_OUTPUT: 05:55:40 INFO - 2015-11-25 05:55:40,486 INFO : Browser exited with error code: 0 05:55:40 INFO - 2015-11-25 05:55:40,501 INFO : Completed test v8_7 (00:00:39) 05:55:40 INFO - 2015-11-25 05:55:40,654 INFO : Completed test suite (00:20:14) 05:55:40 INFO - 2015-11-25 05:55:40,654 DEBUG : Working with test: dromaeo_css 05:55:40 INFO - 2015-11-25 05:55:40,654 DEBUG : Generating results file: dromaeo_css 05:55:40 INFO - 2015-11-25 05:55:40,656 DEBUG : Working with test: kraken 05:55:40 INFO - 2015-11-25 05:55:40,656 DEBUG : Generating results file: kraken 05:55:40 INFO - 2015-11-25 05:55:40,656 INFO : javascript benchmark 05:55:40 INFO - 2015-11-25 05:55:40,656 DEBUG : Working with test: v8_7 05:55:40 INFO - 2015-11-25 05:55:40,656 DEBUG : Generating results file: v8_7 05:55:40 INFO - 2015-11-25 05:55:40,657 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 05:55:40 INFO - 2015-11-25 05:55:40,808 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,1,43]] 05:55:40 INFO - 2015-11-25 05:55:40,808 DEBUG : process_Request line: dromaeo_css 7001.84 graph.html#tests=[[72,1,43]] 05:55:40 INFO - 2015-11-25 05:55:40,808 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 05:55:40 INFO - 2015-11-25 05:55:40,950 DEBUG : process_Request line: kraken 1525.00 graph.html#tests=[[232,1,43]] 05:55:40 INFO - 2015-11-25 05:55:40,950 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 05:55:41 INFO - 2015-11-25 05:55:41,090 DEBUG : process_Request line: v8_7 21515.63 graph.html#tests=[[230,1,43]] 05:55:41 INFO - 2015-11-25 05:55:41,095 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3199.9360012799743, 3262.8857989970356, 3287.5068739689027, 3298.3568204200174, 3309.735221182305, 5293.8941221175555, 5434.3207099112615, 5456.590755693324, 5474.562035037197, 5489.91765123523, 5375.865603359908, 5397.298351214346, 5441.59188060896, 5574.777008919638, 5601.80393686221, 5041.974790126044, 5096.898062038757, 5145.74271286436, 5166.044281807859, 5171.870703232412, 5021.221710634839, 5055.418626857903, 5103.3875934887865, 5150.072986862363, 5165.173572228444, 4870.366852309195, 4944.8269310574315, 4978.377702787152, 5016.698998060128, 5063.088644044071, 5012.473690262543, 5029.321041659366, 5049.899002019975, 5058.038972595232, 5084.593232541425, 5010.824621138279, 5015.824446144404, 5047.848564543069, 5051.419086804991, 5055.5702765265, 5138.100832354323, 5244.685318880879, 5262.394824595182, 5332.200169974496, 5352.0, 5959.165716799652, 6016.916954948108, 6023.849403764897, 6026.6986650667295, 6042.6978651067275, 5726.112452569859, 6014.30835453924, 6021.1269365942135, 6026.156338112668, 6031.853947749957, 5489.917651235235, 5567.8886422271735, 5631.71841407928, 5635.267415235993, 5672.773089076473, 6088.908666370008, 6090.147379366892, 6090.299615544181, 6104.145419641254, 6106.1146133811235, 5614.410486898899, 5707.143928410772, 5885.705714714333, 5886.970565147147, 5893.263342082239, 5871.823845284648, 5912.438318359749, 5916.319623243382, 5922.555808314393, 5929.644221346647, 5824.097264923944, 5877.764889404376, 5916.437938395846, 5919.763209471659, 5929.466348028698, 5722.313322401338, 5777.133429985452, 5823.941760582425, 5915.704214789243, 5926.407359264039, 4612.469565999953, 4619.099275641218, 4619.514950930171, 4621.560951709582, 4630.768461576908, 4123.690723195772, 4126.401671757579, 4134.979325103355, 4138.006878349234, 4164.187983343219, 5503.147012213113, 5581.134924086773, 5632.7746890123935, 5730.799422020209, 5752.964466396089, 5913.970430147821, 5961.880762384728, 5986.2217911671205, 6010.699465026732, 6012.879742405127, 5649.943500564942, 5676.290463692038, 5691.658500489983, 5692.743826527816, 5702.800401985911, 4931.112399768004, 5066.695998240118, 5105.106606343875, 5133.6919784813035, 5189.610779191576, 6108.419700128481, 6197.287311959182, 6199.938000620026, 6200.007998720183, 6202.162708034538, 6002.969985150046, 6006.87986240264, 6015.338312785502, 6031.336552979081, 6042.697865106815, 5797.623154494944, 5969.582129250911, 5988.820335389771, 6099.672983688876, 6128.417800308964, 5911.172435858897, 5912.940870591411, 5939.46544810969, 5944.494717949023, 5947.405259474191, 5804.071348584206, 5998.400159984141, 6014.218151640259, 6044.15381846533, 6048.183495228088, 5690.715464226855, 5774.855628609318, 5861.9706901465215, 5869.970650146722, 5921.5854890159, 5833.620814647034, 5869.8239052828485, 5872.853178670567, 5884.0585506318785, 5902.2622172228475, 5553.972230138824, 5669.858253543694, 5762.250907382014, 5781.537477001746, 5783.0, 5716.28546431696, 5812.18629391877, 5812.912806307993, 5814.883702325845, 5824.039033559585, 5627.88744225105, 5628.493435590816, 5654.123610840326, 5678.943210568007, 5679.74441150141], "unit": "ms", "name": "dojo.html", "value": 5473.431209182604}, {"lowerIsBetter": false, "replicates": [580.1471836400495, 586.5776640818609, 591.9289685237773, 592.7332700284873, 594.1473984831769, 32242.0, 40705.79647101764, 40829.97925051875, 41044.58955410445, 41125.0, 42643.57356426435, 43110.0, 43147.99999999992, 43302.35046474305, 43310.35034474485, 8497.617607207674, 8735.563221838915, 8756.255718263956, 8762.912370876305, 8804.559772011406, 8501.744947651581, 8632.568371581427, 8635.870461943075, 8649.394542382035, 8656.047834738174, 8581.656733730642, 8659.870101948476, 8660.090690477504, 8734.912650873504, 8735.301175905912, 8614.698485553006, 8677.0, 8707.216350528452, 8716.08481109484, 8719.433236839648, 8508.191721786421, 8656.913430865674, 8682.522461264627, 8698.521581313025, 8726.738197854074, 41091.58908410907, 41415.585844141475, 41591.0, 41676.37485437721, 41714.1657166858, 3249.772515923886, 3294.7199488043307, 3311.768176227665, 3325.1022223999385, 3367.1582104473882, 29854.552181717292, 30229.0, 30437.782488700424, 30745.692543074507, 31430.842845785854, 3646.2707458508403, 3666.871659491905, 3711.851525938986, 3753.0429740416293, 3832.7891965941863, 268978.0, 269382.0, 271220.0, 271765.0, 272546.0, 53213.0, 53906.19140712892, 59204.703976480705, 59578.106328405105, 67846.32153678499, 63606.363936360045, 63809.0, 63847.36152638507, 63902.680486597266, 64158.0, 15395.230238488031, 15556.455524056604, 15602.375904963901, 15624.609384765245, 15638.687226255412, 10507.264491485676, 10538.156947444186, 10579.10077643409, 10594.947025264979, 10597.417142057107, 20236.291729789387, 20575.58848823015, 20687.8965605171, 20903.79096209049, 20934.895325523274, 7340.641981233489, 7377.594232317167, 7472.589007604634, 7520.586367749717, 7587.089549254125, 895.5029958373166, 983.6360546597662, 1047.0994944347856, 1053.5627714498398, 1078.4230436716318, 28128.43743125126, 28373.0, 28877.855610721814, 28951.56572651412, 28988.85505572501, 1090.7218659241842, 1112.1769890281296, 1112.7273817914663, 1130.0225305111185, 1172.050638982427, 13761.931190343985, 14267.215303158218, 14294.714105717827, 14346.784798228035, 14609.561713148623, 326152.0, 330427.0, 331247.0, 331354.0, 331943.0, 52090.21864672033, 52147.0, 52563.21155182675, 52585.47414525806, 52615.21077183845, 1286.0997301888715, 1320.2804471563022, 1335.2455862437691, 1337.190999445341, 1352.425219281821, 26934.730652693223, 27915.302117447227, 28070.85964570164, 28335.29161770972, 29153.85423072871, 44382.77808610936, 44434.11131777411, 44881.32678009767, 44945.10109797851, 45102.77448612736, 224321.0, 225533.0, 225645.0, 225808.0, 226076.0, 31203.84398077995, 31339.373212536077, 31743.52384714185, 31848.681513184572, 32183.51724724084, 39648.20703585855, 41908.0, 42518.574814251464, 43291.78354108335, 43593.78203109091, 35063.64936350604, 36046.639533605376, 36153.819230903675, 36357.09107272339, 36630.0, 33169.50245746364, 33801.323973520884, 33809.0, 33999.0, 36672.81663591665, 34675.0, 35127.47308790319, 35407.645923541466, 35515.0, 35570.288594228485, 31832.840835795672, 32538.965102765087, 32615.836920815244, 32875.67124328822, 33250.50124248186, 25297.62053569235, 26798.59802103009, 26915.0, 26958.0, 27033.86483067572], "unit": "ms", "name": "ext.html", "value": 18334.093042093693}, {"lowerIsBetter": false, "replicates": [351.1186920828719, 353.6145601294588, 358.1351037245053, 358.35674963440624, 358.9802560859152, 16623.83376166238, 17232.396866109688, 17604.0, 18151.092445377744, 18200.4539863804, 14626.341814618341, 14848.0, 15061.39754409825, 15161.393544258217, 15234.695306093872, 4779.545943135397, 4927.482614325498, 4966.329545511364, 4974.527419895122, 4980.402351717799, 4975.179095449264, 5020.0712868119335, 5025.271335656346, 5025.698458092508, 5029.9748501257445, 4867.36724225852, 4954.628402869781, 5047.520485553867, 5174.249733788598, 5204.531592156705, 5079.542841144296, 5095.980803839247, 5112.948870511303, 5113.514216149497, 5235.319408476912, 5217.321748172713, 5230.398504172031, 5237.4500677428705, 5255.39562950258, 5260.026895024433, 12453.0, 15364.769528457082, 18962.43112706621, 19877.30429434963, 19933.601327973505, 2040.0207900207984, 2075.2217918280644, 2120.9151633934625, 2135.4981579328846, 2145.4850835799452, 9782.608695652165, 9995.550200240934, 11246.943765281203, 12950.158239714388, 13436.664083397896, 1759.6216813385056, 1896.2888916656254, 1896.6680830854684, 1896.7913529511743, 1899.373206841739, 62689.68655156695, 64529.67735161294, 64968.350316496704, 65101.0, 66197.0, 9413.0, 9509.381890177116, 9636.518174091407, 9637.518124093907, 9665.275104367201, 12402.875971240353, 12459.439325230387, 12558.434870430852, 12575.371231438392, 12622.621321360373, 7053.858922821515, 7137.750178743823, 7147.678354474061, 7166.889132184519, 7483.850322993619, 6738.764143254963, 6847.0, 6878.105846239957, 6905.343992320722, 6978.127734033246, 4290.892727681833, 4339.479262488521, 4366.214081465367, 4388.692791504564, 4458.130664520388, 1801.3155001099499, 1811.085401872046, 1821.9089045547669, 1865.5709186887093, 1880.6332765110947, 909.2544113826599, 966.2173639352147, 968.8934217236099, 976.6679329028165, 983.5229913491951, 14912.956093073597, 15976.920115399582, 17212.311507539558, 17665.911670441565, 18158.45524634263, 936.2603543200931, 941.1294552538874, 943.429225318686, 965.285688590438, 967.0571193086685, 9553.283503737248, 9653.662121825702, 9804.166645835041, 9847.409155450696, 9897.80204395908, 532463.0, 536997.0, 546174.0, 549407.0, 554420.0, 78078.0, 78843.60578197187, 79782.0, 80204.0, 80552.0, 1145.7250259937555, 1153.8903804138592, 1160.5531870229854, 1163.662537864027, 1164.5050853387277, 15166.620834479227, 15181.696366072838, 15263.0, 15286.0, 15479.458218962282, 34867.0, 35068.298634027684, 35267.82366088153, 35510.0, 36713.632863671024, 48791.75604121957, 48841.26738099002, 50532.24201636905, 51731.96536069333, 52083.0, 9453.33826632129, 9578.473183974947, 9585.233181345615, 9678.128968392879, 9680.709578712649, 15717.214139293219, 16594.834051659327, 16708.164591770605, 16925.407610733564, 16958.660826783642, 13635.318234088058, 13968.092074015156, 14150.575482735534, 14399.0, 14632.268386580416, 14409.639759006108, 14437.422503099759, 14569.0, 15014.324355404251, 15107.244637767848, 14942.551723448314, 15139.167345796088, 15170.165640889856, 15473.0, 15570.377184912477, 9311.72064838056, 9576.425414475154, 9579.616815327308, 9649.46927918943, 9835.409875407498, 14628.634284142981, 14672.633184170054, 14841.554753357417, 14862.479813206486, 14982.708061466907], "unit": "ms", "name": "jquery.html", "value": 8825.832232418508}, {"lowerIsBetter": false, "replicates": [1492.02272511505, 1697.3974239145102, 1714.5285046612187, 1728.3345911823944, 1765.161548264574, 7044.401225895798, 7141.500094993353, 7348.926510734905, 7491.625418729062, 7492.662830172649, 7107.147142342913, 7194.352508274254, 7214.314640109194, 7221.9277807221915, 7230.96384518078, 1996.3212507747398, 2039.39837747864, 2042.6416433071988, 2042.908069136885, 2044.8773073615557, 2170.9457263568456, 2225.9888700556476, 2246.9438264043365, 2247.438140464884, 2253.3690566641367, 2186.2348178137604, 2200.119952019197, 2215.3132528916008, 2223.566404551113, 2226.6548684953777, 2070.2960993262286, 2096.4130043587743, 2097.402240361497, 2097.5595125023765, 2098.9685154722692, 2181.5418762059985, 2248.730152381708, 2275.8520696154696, 2280.065173278948, 2280.9429764256024, 7241.601711905843, 7336.853262934711, 7341.0, 7379.59412232327, 7385.335319821188, 4320.4599425071865, 4375.234333991539, 4375.78121093944, 4376.23415902219, 4389.836693276285, 2930.868110935013, 2941.76465882731, 2984.7761417893526, 2987.118799954019, 3005.9398812023855, 903.5888670654837, 914.862770584411, 917.9856258833959, 975.2393133355923, 979.2459805949379, 9776.462294573796, 9835.557399917021, 9885.159761420287, 9927.106560409598, 9949.154321882721, 4043.7775922324554, 4048.21059893318, 4112.794360281974, 4114.732542384735, 4128.876133715993, 8546.743597692079, 8567.528785916835, 8568.871466928002, 8575.1424857515, 8578.528180950108, 4440.289553671397, 4447.2439685253585, 4452.198604251201, 4485.596296333346, 4487.192305385062, 3938.330483817758, 4046.3323551614244, 4073.7759423232005, 4113.732607380511, 4128.958710412918, 3430.879919202816, 3469.323481921001, 3475.270193259393, 3504.229069604683, 3504.9649503505148, 1083.4853444613746, 1102.1513434655271, 1105.8175401058895, 1110.4059328259343, 1115.6987613344352, 947.052947052947, 960.519740129935, 966.3477152921749, 1059.89930956559, 1353.4653811744306, 6717.227518835299, 6730.0, 6744.156980377453, 6777.898331525031, 6826.93173068263, 457.3345781887346, 1172.4255114993591, 1191.8986886114778, 1195.205188549622, 1207.4264724255909, 5509.201165831012, 5515.7242137892945, 5568.749406276727, 5577.6932268724795, 5615.466530679579, 8291.33669306454, 8389.664413423518, 8606.096359882122, 8639.740807775777, 8648.221660050625, 8616.48301101936, 8631.007434145027, 8653.870191947126, 8704.869426958601, 8739.56302184901, 6903.309669033057, 6910.827229319308, 6936.965315173493, 6965.442764578822, 6966.303369662993, 6473.0, 6519.152510173647, 6524.478041756743, 6567.638779867153, 6590.308017658077, 7642.197569255371, 7751.7674469766, 7845.5684937329, 7918.326942209746, 7993.12075671664, 7862.1351651319455, 8077.636506357346, 8107.270345668918, 8169.387295952709, 8170.468919520212, 6331.90502142459, 6335.1130841683125, 6385.13800636908, 6597.340265973365, 6641.070250165078, 7147.0, 7167.820804479929, 7187.281271872771, 7192.460565457507, 7203.71185152588, 6621.933780662324, 6739.6967136478, 6758.357955994173, 6787.796366109024, 6909.723611055702, 6589.670516474253, 6661.900071499028, 6715.966420167868, 6735.797926062226, 6746.932530674827, 6624.337566243337, 6637.303083176197, 6684.364985326386, 6694.397504224448, 6699.698513566804, 5988.011978023577, 5998.070299103646, 6060.303065147565, 6064.666443345658, 6069.51443884497, 6186.072089186658, 6251.6561589113035, 6279.309275979547, 6279.686015699288, 6293.590916590407], "unit": "ms", "name": "mootools.html", "value": 4249.3684824750835}, {"lowerIsBetter": false, "replicates": [301.22885413341845, 309.8512713897329, 320.6809224821303, 322.38907270721967, 323.90768630940187, 6178.382161783825, 6277.435030847223, 6333.841653958653, 6388.680565971695, 6481.351864813516, 6284.622922624646, 6331.176946996896, 6355.173827402443, 6356.5868218565765, 6362.395572420613, 4800.159972004903, 4804.399450068741, 4805.879853003668, 4809.230523116294, 4818.734969576672, 4791.856244312677, 4799.592034677056, 4805.927911081337, 4806.038792241566, 4808.711477311355, 4662.8134874604975, 4743.85768426946, 4748.406449193851, 4748.810047598092, 4748.976255118737, 4716.952830471686, 4718.693284936468, 4719.90560188796, 4739.597134243559, 4747.145513807513, 4071.7760523171214, 4074.449949256842, 4076.3681629347498, 4077.55146933837, 4080.755154690728, 6020.096985452174, 6030.12563178341, 6045.3047899491685, 6058.4244496772735, 6068.6662233577135, 5336.0, 5483.670979741229, 5487.094629386146, 5504.587155963279, 5507.311586051744, 6680.83297917556, 6683.3650803174105, 6686.498512611525, 6686.565373250772, 6699.39705426514, 4511.120331535352, 4511.661625378077, 4512.210363186429, 4513.819447222108, 4517.435320584927, 6780.220274668427, 6890.276520965276, 6919.411849992756, 6936.34104760052, 6967.825804354881, 4597.517260687647, 4610.239310513794, 4610.907781844345, 4613.677042606985, 4618.214903466419, 4657.0, 4662.417197850269, 4666.113438446684, 4672.275797251432, 4676.55572720591, 5448.700321482277, 5450.591205659592, 5459.972700136474, 5463.508284254436, 5471.50756431923, 6512.5766825156215, 6680.265170831205, 6704.631245281556, 6737.8652426951185, 6741.35957084086, 1602.166873225916, 1606.9598260043358, 1649.4556796257207, 1652.4381710218584, 1653.4047742812577, 1061.8407238914224, 1071.5553045486192, 1071.983920241197, 1074.5272080284649, 1077.49357801833, 6390.105385246069, 6412.0, 6433.099366088752, 6436.903446448307, 6437.388448097423, 6793.898091528631, 6805.455563554904, 6822.420094292041, 6824.112865327575, 6827.69275382609, 6369.777057802955, 6418.646974416359, 6428.100065990765, 6434.420902118738, 6447.1296374989715, 3798.9620103798607, 3810.2189051244427, 3820.4269359596283, 3825.2731980923536, 3828.1386687994977, 7206.171290301578, 7223.494355395072, 7238.167610724729, 7247.818804529929, 7249.673764680602, 6922.376986071277, 7135.179454362815, 7140.857182856314, 7148.356647901714, 7150.892736608955, 7134.2509036551455, 7173.820654483679, 7196.244394338623, 7217.6030318333, 7241.2396698346965, 6941.583504989717, 6960.338767817049, 6971.0, 6980.301969802979, 6983.615901125284, 6721.22705888829, 6855.828604284933, 6906.274841141608, 6914.308569143045, 6916.3429474199875, 7206.927930720835, 7208.423326133792, 7214.675339609835, 7231.204567497676, 7242.891356629761, 4558.225101732647, 4603.286490593963, 4611.654125940635, 4614.676972612019, 4622.0, 6826.078479405217, 6948.513604047668, 6956.2695916930015, 6961.79114626562, 6982.965085174542, 6701.262861085374, 6732.899006515004, 6777.661116944231, 6777.661116944231, 6778.423833974168, 6763.7632682855865, 6771.28901465339, 6773.796786096425, 6775.186977562724, 6781.728730850711, 6495.772647957298, 6631.734730610721, 6636.303188165173, 6645.3022432643875, 6648.601083934979, 6787.830304242236, 6793.830154246183, 6794.4904132189295, 6795.830104247433, 6804.795856124324, 6592.17597800275, 6592.241892182268, 6613.570117942319, 6620.735170593122, 6624.105745724266], "unit": "ms", "name": "prototype.html", "value": 5003.794342137257}, {"lowerIsBetter": false, "replicates": [752.2439947852407, 755.7921571567819, 837.1293854391433, 858.1675774498734, 872.2280781508363, 12877.291748953803, 13138.540151094714, 13301.334933253323, 13324.0, 13327.466901323935, 12752.426140823662, 12862.163959342659, 12887.0, 12903.483860645587, 13207.6698082548, 816.0411516468156, 824.9546274954876, 827.8675411934091, 830.4892491117979, 831.8419500294955, 821.3757544266371, 823.9258466737992, 833.6498670558381, 839.0225387423644, 839.2069494327862, 868.8696695495663, 873.5457562067753, 874.470945078228, 875.8861348024748, 879.0462348352046, 863.2575984653193, 869.3523325122824, 873.10506730601, 873.6592728835727, 876.3208513402101, 639.3829954094275, 639.68015992004, 639.9296077431479, 640.993590064098, 641.5893827950116, 13641.931790341085, 13695.589132326046, 13838.100523465942, 13855.445782168701, 13888.375023123883, 11712.53149874004, 11995.400229988552, 12085.274883507018, 12422.130450868442, 12890.162139461, 9891.752706182331, 10251.436171010591, 10336.121429678486, 10475.63335283269, 10553.208509361828, 3579.928401431957, 3658.4512323151475, 3661.377565813818, 3687.1519550503267, 3705.7220708446976, 43007.78496107499, 43339.349909751065, 45541.54458455406, 46101.30848037282, 46107.53892461066, 9986.450745209084, 10531.631392901212, 10574.841377379345, 10576.788464230673, 10647.14822814173, 17975.55061123456, 18116.275348986157, 18130.45608631743, 18170.18234179465, 18260.26958921628, 7369.926300736924, 7461.85076298471, 7577.318041376303, 7705.537667739954, 7772.7668169954995, 4203.747775133502, 4294.240910490332, 4300.462442194726, 4326.891827704332, 4506.143832671782, 2950.808197467201, 2992.9102126936227, 2993.3115383461927, 3005.1735772662255, 3007.3985202959498, 535.713393334572, 537.543088374886, 547.0481362429424, 550.2681433693178, 564.8841987392575, 505.27997603414985, 531.8909623527168, 584.9824505264849, 699.2552931128332, 718.8741970155306, 8628.827423451496, 8649.178328058824, 8743.475391476532, 8820.691275805317, 8823.382363234512, 551.5146670929637, 557.239368262319, 647.6567419267795, 705.1256442011868, 709.0959027240207, 3759.285735710206, 3786.3563194257044, 4054.688827368431, 4249.40508328828, 4378.78106094694, 55300.0, 57546.0, 57718.0, 57933.710331448914, 58642.706786465795, 49910.50089499058, 50427.747861261196, 50621.0, 51735.74132129315, 52070.21894671583, 43315.0, 46419.0, 46475.30287045697, 46527.0, 47443.0, 8588.141185881363, 8667.956660216658, 8736.956315218384, 8769.868451973098, 8798.560071996502, 34310.48534272038, 34999.82500087585, 35406.645933540334, 36185.27629447449, 36201.45697814588, 41275.793621032906, 41490.58509414867, 44406.77796610996, 45018.549814502745, 45532.77233613811, 10338.12125969301, 10512.947435262775, 10749.086327661924, 10903.12774977984, 11127.499262533367, 11135.83296250573, 11459.569418545663, 11688.357140357362, 12035.699107522381, 12457.06572007085, 10895.346279223271, 11422.200445968703, 11701.941490292495, 11718.179727419, 12313.692157696129, 10162.288639795439, 10299.948500257451, 10309.793804123725, 10726.463676815973, 11044.226904116957, 11091.389973551532, 11204.887951120385, 11212.878712128722, 11381.601643942422, 11608.589048220656, 8277.535613175914, 8683.522406267715, 8711.956440218011, 8815.735527934172, 9170.541472926461, 8599.699010534601, 9249.213816825646, 9282.953585232031, 9283.48940808262, 9297.163255307054], "unit": "ms", "name": "yui.html", "value": 6256.574517166829}], "name": "dromaeo_css"}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [112.0, 106.0, 113.0, 112.0, 111.0, 125.0, 113.0, 113.0, 110.0, 111.0], "unit": "ms", "name": "ai-astar", "value": 112.6}, {"lowerIsBetter": true, "replicates": [155.0, 126.0, 162.0, 163.0, 128.0, 152.0, 161.0, 131.0, 160.0, 126.0], "unit": "ms", "name": "audio-beat-detection", "value": 146.4}, {"lowerIsBetter": true, "replicates": [162.0, 163.0, 164.0, 164.0, 163.0, 161.0, 161.0, 164.0, 175.0, 163.0], "unit": "ms", "name": "audio-dft", "value": 164.0}, {"lowerIsBetter": true, "replicates": [72.0, 72.0, 71.0, 71.0, 72.0, 74.0, 139.0, 89.0, 71.0, 71.0], "unit": "ms", "name": "audio-fft", "value": 80.2}, {"lowerIsBetter": true, "replicates": [92.0, 94.0, 134.0, 93.0, 94.0, 93.0, 142.0, 95.0, 93.0, 141.0], "unit": "ms", "name": "audio-oscillator", "value": 107.1}, {"lowerIsBetter": true, "replicates": [110.0, 110.0, 109.0, 109.0, 111.0, 112.0, 110.0, 110.0, 110.0, 111.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 110.2}, {"lowerIsBetter": true, "replicates": [147.0, 146.0, 146.0, 147.0, 147.0, 146.0, 146.0, 147.0, 147.0, 147.0], "unit": "ms", "name": "imaging-darkroom", "value": 146.6}, {"lowerIsBetter": true, "replicates": [97.0, 98.0, 97.0, 97.0, 96.0, 95.0, 96.0, 97.0, 96.0, 97.0], "unit": "ms", "name": "imaging-desaturate", "value": 96.6}, {"lowerIsBetter": true, "replicates": [61.0, 61.0, 63.0, 61.0, 61.0, 61.0, 61.0, 61.0, 60.0, 58.0], "unit": "ms", "name": "json-parse-financial", "value": 60.8}, {"lowerIsBetter": true, "replicates": [70.0, 71.0, 71.0, 70.0, 71.0, 70.0, 71.0, 71.0, 75.0, 70.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 71.0}, {"lowerIsBetter": true, "replicates": [85.0, 87.0, 87.0, 86.0, 87.0, 86.0, 87.0, 86.0, 95.0, 86.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 87.2}, {"lowerIsBetter": true, "replicates": [115.0, 138.0, 123.0, 117.0, 119.0, 130.0, 136.0, 119.0, 127.0, 120.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 124.4}, {"lowerIsBetter": true, "replicates": [152.0, 150.0, 150.0, 150.0, 150.0, 149.0, 148.0, 150.0, 141.0, 153.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 149.3}, {"lowerIsBetter": true, "replicates": [69.0, 66.0, 66.0, 69.0, 66.0, 78.0, 69.0, 67.0, 66.0, 70.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 68.6}], "name": "kraken"}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [166.5278934221482], "unit": "score", "name": "Richards", "value": 211.98851000000005}, {"lowerIsBetter": false, "replicates": [191.57088122605364], "unit": "score", "name": "DeltaBlue", "value": 345.13596000000007}, {"lowerIsBetter": false, "replicates": [279.79854504756577], "unit": "score", "name": "Encrypt", "value": 951.330894}, {"lowerIsBetter": false, "replicates": [5164.948453608247], "unit": "score", "name": "Decrypt", "value": 51.53604191616765}, {"lowerIsBetter": false, "replicates": [1051.4705882352941], "unit": "score", "name": "RayTrace", "value": 703.7657622377623}, {"lowerIsBetter": false, "replicates": [714.2857142857143], "unit": "score", "name": "Earley", "value": 933.0482000000002}, {"lowerIsBetter": false, "replicates": [12280.487804878048], "unit": "score", "name": "Boyer", "value": 54.27007547169812}, {"lowerIsBetter": false, "replicates": [24902.439024390245], "unit": "score", "name": "RegExp", "value": 36.58215964740448}, {"lowerIsBetter": false, "replicates": [569.4760820045558], "unit": "score", "name": "Splay", "value": 143.098196}, {"lowerIsBetter": false, "replicates": [4859.223300970873], "unit": "score", "name": "NavierStokes", "value": 305.39860139860156}], "name": "v8_7"}]} 05:55:41 INFO - RETURN: dromaeo_css: 7001.84 05:55:41 INFO - RETURN: kraken: 1525.00 05:55:41 INFO - RETURN: v8_7: 21515.63 05:55:41 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,1,43]]", "result": "21515.63"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,1,43]]", "result": "1525.00"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,1,43]]", "result": "7001.84"}}} 05:55:41 INFO - Return code: 0 05:55:41 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 05:55:41 INFO - # TBPL SUCCESS # 05:55:41 INFO - Running post-action listener: _resource_record_post_action 05:55:41 INFO - Running post-run listener: _resource_record_post_run 05:55:42 INFO - Total resource usage - Wall time: 1230s; CPU: 13.0%; Read bytes: 10440704; Write bytes: 420786176; Read time: 3064; Write time: 420888 05:55:42 INFO - install - Wall time: 15s; CPU: 13.0%; Read bytes: 0; Write bytes: 23703552; Read time: 0; Write time: 23960 05:55:42 INFO - run-tests - Wall time: 1215s; CPU: 13.0%; Read bytes: 10436608; Write bytes: 397082624; Read time: 3016; Write time: 396928 05:55:42 INFO - Running post-run listener: _upload_blobber_files 05:55:42 INFO - Blob upload gear active. 05:55:42 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 05:55:42 INFO - Copying logs to upload dir... 05:55:42 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1277.398068 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 17 secs) (at 2015-11-25 05:55:42.308941) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-25 05:55:42.312525) ========= 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=20aa3857bbc5a756c598c738000001bb-1448458142.577917-117337063 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/K7V4RDtZQ_2QUQmqJz7NIg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.009897 build_url: 'https://queue.taskcluster.net/v1/task/K7V4RDtZQ_2QUQmqJz7NIg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2' ========= master_lag: 0.05 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-25 05:55:42.368474) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-25 05:55:42.369320) ========= 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=20aa3857bbc5a756c598c738000001bb-1448458142.577917-117337063 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004498 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-25 05:55:42.423178) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-25 05:55:42.423714) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-25 05:55:42.424383) ========= ========= Total master_lag: 0.20 =========