builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-015 starttime: 1448456064.23 results: success (0) buildid: 20151125023015 builduid: ddb878b2f0d6449c9155a8e9898f1072 revision: 80cc747d4e5e64f9e37e2eba98be52fcc772ad19 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-11-25 04:54:24.232664) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-11-25 04:54:24.233196) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-25 04:54:24.233490) ========= bash -c pwd in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'pwd'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=70a720fcaf18edea6683c2dc000001ad-1448451981.625073-1036322318 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.009109 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-25 04:54:24.258251) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-25 04:54:24.258770) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-25 04:54:24.289743) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-25 04:54:24.290162) ========= rm -rf properties in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'properties'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=70a720fcaf18edea6683c2dc000001ad-1448451981.625073-1036322318 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004576 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-25 04:54:24.340550) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-25 04:54:24.340866) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-25 04:54:24.341277) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-25 04:54:24.341552) ========= bash -c 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py' in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=70a720fcaf18edea6683c2dc000001ad-1448451981.625073-1036322318 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-11-25 04:54:24-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 42.0M=0s 2015-11-25 04:54:24 (42.0 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.140893 ========= master_lag: 0.04 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-25 04:54:24.518477) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-25 04:54:24.518799) ========= rm -rf scripts in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=70a720fcaf18edea6683c2dc000001ad-1448451981.625073-1036322318 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015851 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-25 04:54:24.575768) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-25 04:54:24.576147) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 80cc747d4e5e64f9e37e2eba98be52fcc772ad19 --destination scripts --debug' in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev 80cc747d4e5e64f9e37e2eba98be52fcc772ad19 --destination scripts --debug'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=70a720fcaf18edea6683c2dc000001ad-1448451981.625073-1036322318 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-11-25 04:54:24,833 truncating revision to first 12 chars 2015-11-25 04:54:24,833 Setting DEBUG logging. 2015-11-25 04:54:24,833 attempt 1/10 2015-11-25 04:54:24,833 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/80cc747d4e5e?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-11-25 04:54:25,090 unpacking tar archive at: fx-team-80cc747d4e5e/testing/mozharness/ program finished with exit code 0 elapsedTime=0.536000 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-25 04:54:25.129196) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-25 04:54:25.129508) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-25 04:54:25.139017) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-25 04:54:25.139383) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-25 04:54:25.139813) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 3 secs) (at 2015-11-25 04:54:25.140124) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test-pgo/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--system-bits', '64', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test-pgo/buildprops.json PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=70a720fcaf18edea6683c2dc000001ad-1448451981.625073-1036322318 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 04:54:25 INFO - MultiFileLogger online at 20151125 04:54:25 in /builds/slave/test-pgo 04:54:25 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 04:54:25 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 04:54:25 INFO - {'append_to_log': False, 04:54:25 INFO - 'base_work_dir': '/builds/slave/test-pgo', 04:54:25 INFO - 'blob_upload_branch': 'Fx-Team', 04:54:25 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 04:54:25 INFO - 'branch': 'Fx-Team', 04:54:25 INFO - 'buildbot_json_path': 'buildprops.json', 04:54:25 INFO - 'config_files': ('talos/linux_config.py',), 04:54:25 INFO - 'default_actions': ('clobber', 04:54:25 INFO - 'read-buildbot-config', 04:54:25 INFO - 'download-and-extract', 04:54:25 INFO - 'populate-webroot', 04:54:25 INFO - 'create-virtualenv', 04:54:25 INFO - 'install', 04:54:25 INFO - 'run-tests'), 04:54:25 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:54:25 INFO - 'download_minidump_stackwalk': True, 04:54:25 INFO - 'download_symbols': 'ondemand', 04:54:25 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:54:25 INFO - 'tooltool.py': '/tools/tooltool.py', 04:54:25 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:54:25 INFO - '/tools/misc-python/virtualenv.py')}, 04:54:25 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:54:25 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:54:25 INFO - 'installer_path': 'installer.exe', 04:54:25 INFO - 'log_level': 'info', 04:54:25 INFO - 'log_name': 'talos', 04:54:25 INFO - 'log_to_console': True, 04:54:25 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 04:54:25 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 04:54:25 INFO - 'opt_config_files': (), 04:54:25 INFO - 'pip_index': False, 04:54:25 INFO - 'sps_profile': False, 04:54:25 INFO - 'sps_profile_interval': 0, 04:54:25 INFO - 'suite': 'dromaeojs', 04:54:25 INFO - 'system_bits': '64', 04:54:25 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:54:25 INFO - 'title': 'talos-linux64-ix-015', 04:54:25 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:54:25 INFO - 'use_talos_json': True, 04:54:25 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 04:54:25 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:54:25 INFO - 'work_dir': 'build'} 04:54:25 INFO - ##### 04:54:25 INFO - ##### Running clobber step. 04:54:25 INFO - ##### 04:54:25 INFO - Running pre-action listener: _resource_record_pre_action 04:54:25 INFO - Running main action method: clobber 04:54:25 INFO - rmtree: /builds/slave/test-pgo/build 04:54:25 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 04:54:25 INFO - Running post-action listener: _resource_record_post_action 04:54:25 INFO - ##### 04:54:25 INFO - ##### Running read-buildbot-config step. 04:54:25 INFO - ##### 04:54:25 INFO - Running pre-action listener: _resource_record_pre_action 04:54:25 INFO - Running main action method: read_buildbot_config 04:54:25 INFO - Using buildbot properties: 04:54:25 INFO - { 04:54:25 INFO - "properties": { 04:54:25 INFO - "buildnumber": 515, 04:54:25 INFO - "product": "firefox", 04:54:25 INFO - "script_repo_revision": "production", 04:54:25 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 04:54:25 INFO - "repository": "", 04:54:25 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 04:54:25 INFO - "buildid": "20151125023015", 04:54:25 INFO - "slavename": "talos-linux64-ix-015", 04:54:25 INFO - "pgo_build": "True", 04:54:25 INFO - "basedir": "/builds/slave/test-pgo", 04:54:25 INFO - "project": "", 04:54:25 INFO - "platform": "ubuntu64_hw", 04:54:25 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 04:54:25 INFO - "slavebuilddir": "test", 04:54:25 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 04:54:25 INFO - "branch": "fx-team", 04:54:25 INFO - "repo_path": "integration/fx-team", 04:54:25 INFO - "stage_platform": "linux64-pgo", 04:54:25 INFO - "builduid": "ddb878b2f0d6449c9155a8e9898f1072", 04:54:25 INFO - "revision": "80cc747d4e5e64f9e37e2eba98be52fcc772ad19" 04:54:25 INFO - }, 04:54:25 INFO - "sourcestamp": { 04:54:25 INFO - "repository": "", 04:54:25 INFO - "hasPatch": false, 04:54:25 INFO - "project": "", 04:54:25 INFO - "branch": "fx-team-linux64-pgo-talos", 04:54:25 INFO - "changes": [ 04:54:25 INFO - { 04:54:25 INFO - "category": null, 04:54:25 INFO - "files": [ 04:54:25 INFO - { 04:54:25 INFO - "url": null, 04:54:25 INFO - "name": "https://queue.taskcluster.net/v1/task/-6JexqjaSDWkrFJEiNXKMQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2" 04:54:25 INFO - } 04:54:25 INFO - ], 04:54:25 INFO - "repository": "", 04:54:25 INFO - "rev": "80cc747d4e5e64f9e37e2eba98be52fcc772ad19", 04:54:25 INFO - "who": "sendchange", 04:54:25 INFO - "when": 1448455991, 04:54:25 INFO - "number": 6705408, 04:54:25 INFO - "comments": "", 04:54:25 INFO - "project": "", 04:54:25 INFO - "at": "Wed 25 Nov 2015 04:53:11", 04:54:25 INFO - "branch": "fx-team-linux64-pgo-talos", 04:54:25 INFO - "revlink": "", 04:54:25 INFO - "properties": [ 04:54:25 INFO - [ 04:54:25 INFO - "buildid", 04:54:25 INFO - "20151125023015", 04:54:25 INFO - "Change" 04:54:25 INFO - ], 04:54:25 INFO - [ 04:54:25 INFO - "builduid", 04:54:25 INFO - "ddb878b2f0d6449c9155a8e9898f1072", 04:54:25 INFO - "Change" 04:54:25 INFO - ], 04:54:25 INFO - [ 04:54:25 INFO - "pgo_build", 04:54:25 INFO - "True", 04:54:25 INFO - "Change" 04:54:25 INFO - ] 04:54:25 INFO - ], 04:54:25 INFO - "revision": "80cc747d4e5e64f9e37e2eba98be52fcc772ad19" 04:54:25 INFO - } 04:54:25 INFO - ], 04:54:25 INFO - "revision": "80cc747d4e5e64f9e37e2eba98be52fcc772ad19" 04:54:25 INFO - } 04:54:25 INFO - } 04:54:25 INFO - Found installer url https://queue.taskcluster.net/v1/task/-6JexqjaSDWkrFJEiNXKMQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2. 04:54:25 INFO - Running post-action listener: _resource_record_post_action 04:54:25 INFO - ##### 04:54:25 INFO - ##### Running download-and-extract step. 04:54:25 INFO - ##### 04:54:25 INFO - Running pre-action listener: _resource_record_pre_action 04:54:25 INFO - Running main action method: download_and_extract 04:54:25 INFO - mkdir: /builds/slave/test-pgo/build/tests 04:54: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')]} 04:54:25 INFO - https://queue.taskcluster.net/v1/task/-6JexqjaSDWkrFJEiNXKMQ/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 04:54:25 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/-6JexqjaSDWkrFJEiNXKMQ/artifacts/public/build/test_packages.json 04:54:25 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/-6JexqjaSDWkrFJEiNXKMQ/artifacts/public/build/test_packages.json 04:54:25 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/-6JexqjaSDWkrFJEiNXKMQ/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 04:54:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/-6JexqjaSDWkrFJEiNXKMQ/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 04:54:26 INFO - Downloaded 1302 bytes. 04:54:26 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 04:54:26 INFO - Using the following test package requirements: 04:54:26 INFO - {u'common': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 04:54:26 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 04:54:26 INFO - u'firefox-45.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 04:54:26 INFO - u'jittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 04:54:26 INFO - u'jsshell-linux-x86_64.zip'], 04:54:26 INFO - u'mochitest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 04:54:26 INFO - u'firefox-45.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 04:54:26 INFO - u'mozbase': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 04:54:26 INFO - u'reftest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 04:54:26 INFO - u'firefox-45.0a1.en-US.linux-x86_64.reftest.tests.zip'], 04:54:26 INFO - u'talos': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 04:54:26 INFO - u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'], 04:54:26 INFO - u'web-platform': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 04:54:26 INFO - u'firefox-45.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 04:54:26 INFO - u'webapprt': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 04:54:26 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 04:54:26 INFO - u'firefox-45.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 04:54:26 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 04:54: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')]} 04:54:26 INFO - https://queue.taskcluster.net/v1/task/-6JexqjaSDWkrFJEiNXKMQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:54:26 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/-6JexqjaSDWkrFJEiNXKMQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 04:54:26 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/-6JexqjaSDWkrFJEiNXKMQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 04:54:26 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/-6JexqjaSDWkrFJEiNXKMQ/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 04:54:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/-6JexqjaSDWkrFJEiNXKMQ/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 04:54:28 INFO - Downloaded 22530506 bytes. 04:54: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 04:54:28 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 04:54: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 04:54:30 INFO - Return code: 0 04:54:30 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 04:54:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:54:30 INFO - https://queue.taskcluster.net/v1/task/-6JexqjaSDWkrFJEiNXKMQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:54:30 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/-6JexqjaSDWkrFJEiNXKMQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 04:54:30 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/-6JexqjaSDWkrFJEiNXKMQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 04:54:30 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/-6JexqjaSDWkrFJEiNXKMQ/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 04:54:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/-6JexqjaSDWkrFJEiNXKMQ/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 04:54:32 INFO - Downloaded 22530506 bytes. 04:54:32 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 04:54:32 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 04:54:32 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 04:54:33 INFO - Return code: 0 04:54:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:54:33 INFO - https://queue.taskcluster.net/v1/task/-6JexqjaSDWkrFJEiNXKMQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 04:54:33 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/-6JexqjaSDWkrFJEiNXKMQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 04:54:33 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/-6JexqjaSDWkrFJEiNXKMQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 04:54:33 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/-6JexqjaSDWkrFJEiNXKMQ/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 04:54:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/-6JexqjaSDWkrFJEiNXKMQ/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 04:54:34 INFO - Downloaded 11131717 bytes. 04:54:34 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 04:54:34 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 04:54:34 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 04:54:35 INFO - Return code: 0 04:54:35 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')]} 04:54:35 INFO - https://queue.taskcluster.net/v1/task/-6JexqjaSDWkrFJEiNXKMQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 04:54:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/-6JexqjaSDWkrFJEiNXKMQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 04:54:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/-6JexqjaSDWkrFJEiNXKMQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 04:54:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/-6JexqjaSDWkrFJEiNXKMQ/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 04:54:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/-6JexqjaSDWkrFJEiNXKMQ/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 04:54:40 INFO - Downloaded 58388435 bytes. 04:54:40 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/-6JexqjaSDWkrFJEiNXKMQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 04:54:40 INFO - mkdir: /builds/slave/test-pgo/properties 04:54:40 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 04:54:40 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 04:54:40 INFO - Contents: 04:54:40 INFO - build_url:https://queue.taskcluster.net/v1/task/-6JexqjaSDWkrFJEiNXKMQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 04:54:40 INFO - Running post-action listener: _resource_record_post_action 04:54:40 INFO - Running post-action listener: set_extra_try_arguments 04:54:40 INFO - ##### 04:54:40 INFO - ##### Running populate-webroot step. 04:54:40 INFO - ##### 04:54:40 INFO - Running pre-action listener: _resource_record_pre_action 04:54:40 INFO - Running main action method: populate_webroot 04:54:40 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:54:40 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:54:40 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 04:54:40 INFO - '../fennec_ids.txt'], 04:54:40 INFO - 'tests': ['tcheck2']}, 04:54:40 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:54:40 INFO - '--tppagecycles', 04:54:40 INFO - '7'], 04:54:40 INFO - 'tests': ['tsvgm']}}, 04:54:40 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 04:54:40 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 04:54:40 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:54:40 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 04:54:40 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 04:54:40 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 04:54:40 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:54:40 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:54:40 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:54:40 INFO - 'talos_options': ['--e10s'], 04:54:40 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:54:40 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:54:40 INFO - 'tests': ['damp', 'tps']}, 04:54:40 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:54:40 INFO - 'talos_options': ['--e10s'], 04:54:40 INFO - 'tests': ['damp', 'tps']}, 04:54:40 INFO - 'g3': {'tests': ['dromaeo_dom']}, 04:54:40 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:54:40 INFO - 'other': {'tests': ['a11yr', 04:54:40 INFO - 'ts_paint', 04:54:40 INFO - 'tpaint', 04:54:40 INFO - 'sessionrestore', 04:54:40 INFO - 'sessionrestore_no_auto_restore']}, 04:54:40 INFO - 'other-e10s': {'talos_options': ['--e10s'], 04:54:40 INFO - 'tests': ['a11yr', 04:54:40 INFO - 'ts_paint', 04:54:40 INFO - 'tpaint', 04:54:40 INFO - 'sessionrestore', 04:54:40 INFO - 'sessionrestore_no_auto_restore']}, 04:54:40 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 04:54:40 INFO - 'tests': ['a11yr', 04:54:40 INFO - 'ts_paint', 04:54:40 INFO - 'tpaint', 04:54:40 INFO - 'sessionrestore', 04:54:40 INFO - 'sessionrestore_no_auto_restore']}, 04:54:40 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 04:54:40 INFO - 'tests': ['a11yr', 04:54:40 INFO - 'ts_paint', 04:54:40 INFO - 'tpaint', 04:54:40 INFO - 'sessionrestore', 04:54:40 INFO - 'sessionrestore_no_auto_restore']}, 04:54:40 INFO - 'other_l64': {'tests': ['a11yr', 04:54:40 INFO - 'ts_paint', 04:54:40 INFO - 'tpaint', 04:54:40 INFO - 'sessionrestore', 04:54:40 INFO - 'sessionrestore_no_auto_restore']}, 04:54:40 INFO - 'other_nol64': {'tests': ['a11yr', 04:54:40 INFO - 'ts_paint', 04:54:40 INFO - 'tpaint', 04:54:40 INFO - 'sessionrestore', 04:54:40 INFO - 'sessionrestore_no_auto_restore']}, 04:54:40 INFO - 'svgr': {'tests': ['tsvgx', 04:54:40 INFO - 'tsvgr_opacity', 04:54:40 INFO - 'tart', 04:54:40 INFO - 'tscrollx', 04:54:40 INFO - 'cart']}, 04:54:40 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 04:54:40 INFO - 'tests': ['tsvgx', 04:54:40 INFO - 'tsvgr_opacity', 04:54:40 INFO - 'tart', 04:54:40 INFO - 'tscrollx', 04:54:40 INFO - 'cart']}, 04:54:40 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:54:40 INFO - 'tests': ['tp5o']}, 04:54:40 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:54:40 INFO - 'talos_options': ['--e10s'], 04:54:40 INFO - 'tests': ['tp5o']}, 04:54:40 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:54:40 INFO - 'talos_options': ['--xperf_path', 04:54:40 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:54:40 INFO - 'tests': ['tp5n']}, 04:54:40 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:54:40 INFO - 'talos_options': ['--e10s', 04:54:40 INFO - '--xperf_path', 04:54:40 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:54:40 INFO - 'tests': ['tp5n']}}, 04:54:40 INFO - 'talos.zip': {'path': '', 04:54:40 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:54:40 INFO - Running post-action listener: _resource_record_post_action 04:54:40 INFO - ##### 04:54:40 INFO - ##### Running create-virtualenv step. 04:54:40 INFO - ##### 04:54:40 INFO - Running pre-action listener: _resource_record_pre_action 04:54:40 INFO - Running main action method: create_virtualenv 04:54:40 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 04:54:40 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 04:54:40 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 04:54:40 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:54:40 INFO - Using real prefix '/usr' 04:54:40 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 04:54:40 INFO - Installing distribute.............................................................................................................................................................................................done. 04:54:42 INFO - Installing pip.................done. 04:54:42 INFO - Return code: 0 04:54:42 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 04:54:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:54:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:54:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:54:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:54:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:54:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:54:42 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 0x14f7030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16578a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17247d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17b3640>, '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 0x17b4540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17b49d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '70a720fcaf18edea6683c2dc000001ad-1448451981.625073-1036322318', '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 04:54:42 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 04:54:42 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 04:54:42 INFO - Using env: {'DISPLAY': ':0', 04:54:42 INFO - 'HOME': '/home/cltbld', 04:54:42 INFO - 'LANG': 'en_US.UTF-8', 04:54:42 INFO - 'LANGUAGE': 'en_US:en', 04:54:42 INFO - 'LOGNAME': 'cltbld', 04:54:42 INFO - 'MAIL': '/var/mail/cltbld', 04:54:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:54:42 INFO - 'MOZ_NO_REMOTE': '1', 04:54:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:54:42 INFO - 'NO_EM_RESTART': '1', 04:54:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:54:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 04:54:42 INFO - 'PWD': '/builds/slave/test-pgo', 04:54:42 INFO - 'SHELL': '/bin/bash', 04:54:42 INFO - 'SHLVL': '1', 04:54:42 INFO - 'TERM': 'linux', 04:54:42 INFO - 'TMOUT': '86400', 04:54:42 INFO - 'USER': 'cltbld', 04:54:42 INFO - 'XDG_SESSION_COOKIE': '70a720fcaf18edea6683c2dc000001ad-1448451981.625073-1036322318', 04:54:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:54:42 INFO - '_': '/tools/buildbot/bin/python'} 04:54:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:54:43 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 04:54:43 INFO - Cleaning up... 04:54:43 INFO - Return code: 0 04:54:43 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 04:54:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:54:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:54:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:54:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:54:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:54:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:54:43 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x14f7030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16578a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17247d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17b3640>, '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 0x17b4540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17b49d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '70a720fcaf18edea6683c2dc000001ad-1448451981.625073-1036322318', '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 04:54:43 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test-pgo/build 04:54:43 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 04:54:43 INFO - Using env: {'DISPLAY': ':0', 04:54:43 INFO - 'HOME': '/home/cltbld', 04:54:43 INFO - 'LANG': 'en_US.UTF-8', 04:54:43 INFO - 'LANGUAGE': 'en_US:en', 04:54:43 INFO - 'LOGNAME': 'cltbld', 04:54:43 INFO - 'MAIL': '/var/mail/cltbld', 04:54:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:54:43 INFO - 'MOZ_NO_REMOTE': '1', 04:54:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:54:43 INFO - 'NO_EM_RESTART': '1', 04:54:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:54:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 04:54:43 INFO - 'PWD': '/builds/slave/test-pgo', 04:54:43 INFO - 'SHELL': '/bin/bash', 04:54:43 INFO - 'SHLVL': '1', 04:54:43 INFO - 'TERM': 'linux', 04:54:43 INFO - 'TMOUT': '86400', 04:54:43 INFO - 'USER': 'cltbld', 04:54:43 INFO - 'XDG_SESSION_COOKIE': '70a720fcaf18edea6683c2dc000001ad-1448451981.625073-1036322318', 04:54:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:54:43 INFO - '_': '/tools/buildbot/bin/python'} 04:54:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:54:43 INFO - Downloading/unpacking psutil>=0.7.1 04:54:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:54:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:54:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:54:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:54:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:54:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:54:45 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 04:54:45 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 04:54:45 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 04:54:45 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:54:45 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:54:45 INFO - Installing collected packages: psutil 04:54:45 INFO - Running setup.py install for psutil 04:54:45 INFO - building 'psutil._psutil_linux' extension 04:54:45 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 04:54:45 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 04:54:45 INFO - building 'psutil._psutil_posix' extension 04:54:45 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 04:54:45 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 04:54:45 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:54:45 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:54:45 INFO - Successfully installed psutil 04:54:45 INFO - Cleaning up... 04:54:45 INFO - Return code: 0 04:54:45 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 04:54:45 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')]} 04:54:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:54:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:54:45 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')]} 04:54:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:54:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:54:45 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 0x14f7030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16578a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17247d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17b3640>, '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 0x17b4540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17b49d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '70a720fcaf18edea6683c2dc000001ad-1448451981.625073-1036322318', '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 04:54:45 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 04:54:45 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 04:54:45 INFO - Using env: {'DISPLAY': ':0', 04:54:45 INFO - 'HOME': '/home/cltbld', 04:54:45 INFO - 'LANG': 'en_US.UTF-8', 04:54:45 INFO - 'LANGUAGE': 'en_US:en', 04:54:45 INFO - 'LOGNAME': 'cltbld', 04:54:45 INFO - 'MAIL': '/var/mail/cltbld', 04:54:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:54:45 INFO - 'MOZ_NO_REMOTE': '1', 04:54:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:54:45 INFO - 'NO_EM_RESTART': '1', 04:54:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:54:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 04:54:45 INFO - 'PWD': '/builds/slave/test-pgo', 04:54:45 INFO - 'SHELL': '/bin/bash', 04:54:45 INFO - 'SHLVL': '1', 04:54:45 INFO - 'TERM': 'linux', 04:54:45 INFO - 'TMOUT': '86400', 04:54:45 INFO - 'USER': 'cltbld', 04:54:45 INFO - 'XDG_SESSION_COOKIE': '70a720fcaf18edea6683c2dc000001ad-1448451981.625073-1036322318', 04:54:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:54:45 INFO - '_': '/tools/buildbot/bin/python'} 04:54:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:54:45 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 04:54:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:54:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:54:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:54:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:54:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:54:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:54:47 INFO - Downloading mozsystemmonitor-0.0.tar.gz 04:54:47 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 04:54:47 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:54:47 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 04:54:47 INFO - Installing collected packages: mozsystemmonitor 04:54:47 INFO - Running setup.py install for mozsystemmonitor 04:54:47 INFO - Successfully installed mozsystemmonitor 04:54:47 INFO - Cleaning up... 04:54:47 INFO - Return code: 0 04:54:47 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 04:54:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:54:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:54:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:54:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:54:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:54:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:54:47 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 0x14f7030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16578a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17247d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17b3640>, '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 0x17b4540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17b49d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '70a720fcaf18edea6683c2dc000001ad-1448451981.625073-1036322318', '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 04:54:47 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 04:54:47 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 04:54:47 INFO - Using env: {'DISPLAY': ':0', 04:54:47 INFO - 'HOME': '/home/cltbld', 04:54:47 INFO - 'LANG': 'en_US.UTF-8', 04:54:47 INFO - 'LANGUAGE': 'en_US:en', 04:54:47 INFO - 'LOGNAME': 'cltbld', 04:54:47 INFO - 'MAIL': '/var/mail/cltbld', 04:54:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:54:47 INFO - 'MOZ_NO_REMOTE': '1', 04:54:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:54:47 INFO - 'NO_EM_RESTART': '1', 04:54:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:54:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 04:54:47 INFO - 'PWD': '/builds/slave/test-pgo', 04:54:47 INFO - 'SHELL': '/bin/bash', 04:54:47 INFO - 'SHLVL': '1', 04:54:47 INFO - 'TERM': 'linux', 04:54:47 INFO - 'TMOUT': '86400', 04:54:47 INFO - 'USER': 'cltbld', 04:54:47 INFO - 'XDG_SESSION_COOKIE': '70a720fcaf18edea6683c2dc000001ad-1448451981.625073-1036322318', 04:54:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:54:47 INFO - '_': '/tools/buildbot/bin/python'} 04:54:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:54:47 INFO - Downloading/unpacking blobuploader==1.2.4 04:54:47 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 04:54:47 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 04:54:47 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 04:54:47 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 04:54:47 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 04:54:47 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 04:54:49 INFO - Downloading blobuploader-1.2.4.tar.gz 04:54:49 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 04:54:49 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:54:49 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:54:49 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 04:54:49 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 04:54:49 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 04:54:49 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 04:54:49 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 04:54:49 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 04:54:49 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 04:54:49 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 04:54:50 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:54:50 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 04:54:50 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 04:54:50 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 04:54:50 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 04:54:50 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 04:54:50 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 04:54:50 INFO - Downloading docopt-0.6.1.tar.gz 04:54:50 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 04:54:50 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 04:54:50 INFO - Installing collected packages: blobuploader, requests, docopt 04:54:50 INFO - Running setup.py install for blobuploader 04:54:50 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:54:50 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 04:54:50 INFO - Running setup.py install for requests 04:54:50 INFO - Running setup.py install for docopt 04:54:50 INFO - Successfully installed blobuploader requests docopt 04:54:50 INFO - Cleaning up... 04:54:50 INFO - Return code: 0 04:54:50 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 04:54:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:54:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:54:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:54:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:54:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:54:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:54:50 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 0x14f7030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16578a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17247d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17b3640>, '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 0x17b4540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17b49d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '70a720fcaf18edea6683c2dc000001ad-1448451981.625073-1036322318', '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 04:54:50 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 04:54:50 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 04:54:50 INFO - Using env: {'DISPLAY': ':0', 04:54:50 INFO - 'HOME': '/home/cltbld', 04:54:50 INFO - 'LANG': 'en_US.UTF-8', 04:54:50 INFO - 'LANGUAGE': 'en_US:en', 04:54:50 INFO - 'LOGNAME': 'cltbld', 04:54:50 INFO - 'MAIL': '/var/mail/cltbld', 04:54:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:54:50 INFO - 'MOZ_NO_REMOTE': '1', 04:54:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:54:50 INFO - 'NO_EM_RESTART': '1', 04:54:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:54:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 04:54:50 INFO - 'PWD': '/builds/slave/test-pgo', 04:54:50 INFO - 'SHELL': '/bin/bash', 04:54:50 INFO - 'SHLVL': '1', 04:54:50 INFO - 'TERM': 'linux', 04:54:50 INFO - 'TMOUT': '86400', 04:54:50 INFO - 'USER': 'cltbld', 04:54:50 INFO - 'XDG_SESSION_COOKIE': '70a720fcaf18edea6683c2dc000001ad-1448451981.625073-1036322318', 04:54:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:54:50 INFO - '_': '/tools/buildbot/bin/python'} 04:54:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:54:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 04:54:51 INFO - Running setup.py (path:/tmp/pip-3NlelC-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 04:54:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 04:54:51 INFO - Running setup.py (path:/tmp/pip-1jz029-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 04:54:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 04:54:51 INFO - Running setup.py (path:/tmp/pip-NPj0Or-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 04:54:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 04:54:51 INFO - Running setup.py (path:/tmp/pip-mR5IKG-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 04:54:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 04:54:51 INFO - Running setup.py (path:/tmp/pip-lSbNBy-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 04:54:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 04:54:51 INFO - Running setup.py (path:/tmp/pip-OJyp50-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 04:54:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 04:54:51 INFO - Running setup.py (path:/tmp/pip-K0ogn3-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 04:54:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 04:54:51 INFO - Running setup.py (path:/tmp/pip-ibfihq-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 04:54:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 04:54:51 INFO - Running setup.py (path:/tmp/pip-1uprkh-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 04:54:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 04:54:51 INFO - Running setup.py (path:/tmp/pip-1dwwif-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 04:54:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 04:54:51 INFO - Running setup.py (path:/tmp/pip-ydsxZ4-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 04:54:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 04:54:51 INFO - Running setup.py (path:/tmp/pip-JOYlHL-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 04:54:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 04:54:52 INFO - Running setup.py (path:/tmp/pip-64Z0wN-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 04:54:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 04:54:52 INFO - Running setup.py (path:/tmp/pip-OqAi_v-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 04:54:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 04:54:52 INFO - Running setup.py (path:/tmp/pip-lP_3fK-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 04:54:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 04:54:52 INFO - Running setup.py (path:/tmp/pip-eXqEWw-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 04:54:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 04:54:52 INFO - Running setup.py (path:/tmp/pip-5nDKLa-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 04:54:52 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:54:52 INFO - Running setup.py install for manifestparser 04:54:52 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 04:54:52 INFO - Running setup.py install for mozcrash 04:54:52 INFO - Running setup.py install for mozdebug 04:54:52 INFO - Running setup.py install for mozdevice 04:54:52 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 04:54:52 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 04:54:52 INFO - Running setup.py install for mozfile 04:54:52 INFO - Running setup.py install for mozhttpd 04:54:52 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 04:54:52 INFO - Running setup.py install for mozinfo 04:54:53 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 04:54:53 INFO - Running setup.py install for mozInstall 04:54:53 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 04:54:53 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 04:54:53 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 04:54:53 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 04:54:53 INFO - Running setup.py install for mozleak 04:54:53 INFO - Running setup.py install for mozlog 04:54:53 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 04:54:53 INFO - Running setup.py install for moznetwork 04:54:53 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 04:54:53 INFO - Running setup.py install for mozprocess 04:54:53 INFO - Running setup.py install for mozprofile 04:54:53 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 04:54:53 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 04:54:53 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 04:54:53 INFO - Running setup.py install for mozrunner 04:54:53 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 04:54:53 INFO - Running setup.py install for mozscreenshot 04:54:53 INFO - Running setup.py install for moztest 04:54:54 INFO - Running setup.py install for mozversion 04:54:54 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 04:54:54 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:54:54 INFO - Cleaning up... 04:54:54 INFO - Return code: 0 04:54:54 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 04:54:54 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')]} 04:54:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:54:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:54:54 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')]} 04:54:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:54:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:54:54 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 0x14f7030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16578a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17247d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17b3640>, '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 0x17b4540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17b49d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '70a720fcaf18edea6683c2dc000001ad-1448451981.625073-1036322318', '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 04:54:54 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 04:54:54 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 04:54:54 INFO - Using env: {'DISPLAY': ':0', 04:54:54 INFO - 'HOME': '/home/cltbld', 04:54:54 INFO - 'LANG': 'en_US.UTF-8', 04:54:54 INFO - 'LANGUAGE': 'en_US:en', 04:54:54 INFO - 'LOGNAME': 'cltbld', 04:54:54 INFO - 'MAIL': '/var/mail/cltbld', 04:54:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:54:54 INFO - 'MOZ_NO_REMOTE': '1', 04:54:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:54:54 INFO - 'NO_EM_RESTART': '1', 04:54:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:54:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 04:54:54 INFO - 'PWD': '/builds/slave/test-pgo', 04:54:54 INFO - 'SHELL': '/bin/bash', 04:54:54 INFO - 'SHLVL': '1', 04:54:54 INFO - 'TERM': 'linux', 04:54:54 INFO - 'TMOUT': '86400', 04:54:54 INFO - 'USER': 'cltbld', 04:54:54 INFO - 'XDG_SESSION_COOKIE': '70a720fcaf18edea6683c2dc000001ad-1448451981.625073-1036322318', 04:54:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:54:54 INFO - '_': '/tools/buildbot/bin/python'} 04:54:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:54:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 04:54:54 INFO - Running setup.py (path:/tmp/pip-29Nd6k-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 04:54:54 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)) 04:54:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 04:54:54 INFO - Running setup.py (path:/tmp/pip-wbCQZj-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 04:54:54 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)) 04:54:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 04:54:54 INFO - Running setup.py (path:/tmp/pip-smp2BR-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 04:54:54 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)) 04:54:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 04:54:54 INFO - Running setup.py (path:/tmp/pip-Z2yjUk-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 04:54:54 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)) 04:54:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 04:54:54 INFO - Running setup.py (path:/tmp/pip-l2XIzh-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 04:54:54 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)) 04:54:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 04:54:54 INFO - Running setup.py (path:/tmp/pip-1idUHW-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 04:54:54 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)) 04:54:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 04:54:54 INFO - Running setup.py (path:/tmp/pip-BJUeSQ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 04:54:54 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)) 04:54:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 04:54:54 INFO - Running setup.py (path:/tmp/pip-ZhUOkB-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 04:54:54 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)) 04:54:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 04:54:54 INFO - Running setup.py (path:/tmp/pip-s8mpLI-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 04:54:54 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)) 04:54:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 04:54:55 INFO - Running setup.py (path:/tmp/pip-BDvbZg-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 04:54:55 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)) 04:54:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 04:54:55 INFO - Running setup.py (path:/tmp/pip-zC4CBD-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 04:54:55 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)) 04:54:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 04:54:55 INFO - Running setup.py (path:/tmp/pip-GY6UW1-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 04:54:55 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)) 04:54:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 04:54:55 INFO - Running setup.py (path:/tmp/pip-ezZ8UM-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 04:54:55 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)) 04:54:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 04:54:55 INFO - Running setup.py (path:/tmp/pip-_hkNcl-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 04:54:55 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)) 04:54:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 04:54:55 INFO - Running setup.py (path:/tmp/pip-kmq7kf-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 04:54:55 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)) 04:54:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 04:54:55 INFO - Running setup.py (path:/tmp/pip-eZb6IW-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 04:54:55 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)) 04:54:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 04:54:55 INFO - Running setup.py (path:/tmp/pip-uWZ7Qv-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 04:54:55 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)) 04:54:55 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)) 04:54:55 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)) 04:54:55 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)) 04:54:55 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)) 04:54:55 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)) 04:54:55 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 04:54:55 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 04:54:55 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 04:54:55 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 04:54:55 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 04:54:55 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 04:54:55 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 04:54:57 INFO - Downloading blessings-1.5.1.tar.gz 04:54:57 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 04:54:57 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 04:54:57 INFO - Installing collected packages: blessings 04:54:57 INFO - Running setup.py install for blessings 04:54:57 INFO - Successfully installed blessings 04:54:57 INFO - Cleaning up... 04:54:57 INFO - Return code: 0 04:54:57 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 04:54:57 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 04:54:57 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 04:54:57 INFO - Reading from file tmpfile_stdout 04:54:57 INFO - Current package versions: 04:54:57 INFO - argparse == 1.2.1 04:54:57 INFO - blessings == 1.5.1 04:54:57 INFO - blobuploader == 1.2.4 04:54:57 INFO - docopt == 0.6.1 04:54:57 INFO - manifestparser == 1.1 04:54:57 INFO - mozInstall == 1.12 04:54:57 INFO - mozcrash == 0.16 04:54:57 INFO - mozdebug == 0.1 04:54:57 INFO - mozdevice == 0.47 04:54:57 INFO - mozfile == 1.2 04:54:57 INFO - mozhttpd == 0.7 04:54:57 INFO - mozinfo == 0.9 04:54:57 INFO - mozleak == 0.1 04:54:57 INFO - mozlog == 3.1 04:54:57 INFO - moznetwork == 0.27 04:54:57 INFO - mozprocess == 0.22 04:54:57 INFO - mozprofile == 0.27 04:54:57 INFO - mozrunner == 6.11 04:54:57 INFO - mozscreenshot == 0.1 04:54:57 INFO - mozsystemmonitor == 0.0 04:54:57 INFO - moztest == 0.7 04:54:57 INFO - mozversion == 1.4 04:54:57 INFO - psutil == 3.1.1 04:54:57 INFO - requests == 1.2.3 04:54:57 INFO - wsgiref == 0.1.2 04:54:57 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 04:54:57 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')]} 04:54:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:54:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:54:57 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')]} 04:54:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:54:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:54:57 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 0x14f7030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16578a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17247d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17b3640>, '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 0x17b4540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17b49d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build/tests/talos', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '70a720fcaf18edea6683c2dc000001ad-1448451981.625073-1036322318', '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 04:54:57 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 04:54:57 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 04:54:57 INFO - Using env: {'DISPLAY': ':0', 04:54:57 INFO - 'HOME': '/home/cltbld', 04:54:57 INFO - 'LANG': 'en_US.UTF-8', 04:54:57 INFO - 'LANGUAGE': 'en_US:en', 04:54:57 INFO - 'LOGNAME': 'cltbld', 04:54:57 INFO - 'MAIL': '/var/mail/cltbld', 04:54:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:54:57 INFO - 'MOZ_NO_REMOTE': '1', 04:54:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:54:57 INFO - 'NO_EM_RESTART': '1', 04:54:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:54:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 04:54:57 INFO - 'PWD': '/builds/slave/test-pgo', 04:54:57 INFO - 'SHELL': '/bin/bash', 04:54:57 INFO - 'SHLVL': '1', 04:54:57 INFO - 'TERM': 'linux', 04:54:57 INFO - 'TMOUT': '86400', 04:54:57 INFO - 'USER': 'cltbld', 04:54:57 INFO - 'XDG_SESSION_COOKIE': '70a720fcaf18edea6683c2dc000001ad-1448451981.625073-1036322318', 04:54:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:54:57 INFO - '_': '/tools/buildbot/bin/python'} 04:54:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:54:57 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)) 04:54:57 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)) 04:54:57 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)) 04:54:57 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)) 04:54:57 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)) 04:54:57 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)) 04:54:57 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)) 04:54:57 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)) 04:54:57 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)) 04:54:57 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)) 04:54:57 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)) 04:54:57 INFO - Cleaning up... 04:54:57 INFO - Return code: 0 04:54:57 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 04:54:57 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')]} 04:54:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:54:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:54:57 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')]} 04:54:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:54:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:54:57 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 0x14f7030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16578a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17247d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17b3640>, '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 0x17b4540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17b49d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '70a720fcaf18edea6683c2dc000001ad-1448451981.625073-1036322318', '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 04:54:57 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 04:54:57 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 04:54:57 INFO - Using env: {'DISPLAY': ':0', 04:54:57 INFO - 'HOME': '/home/cltbld', 04:54:57 INFO - 'LANG': 'en_US.UTF-8', 04:54:57 INFO - 'LANGUAGE': 'en_US:en', 04:54:57 INFO - 'LOGNAME': 'cltbld', 04:54:57 INFO - 'MAIL': '/var/mail/cltbld', 04:54:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:54:57 INFO - 'MOZ_NO_REMOTE': '1', 04:54:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:54:57 INFO - 'NO_EM_RESTART': '1', 04:54:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:54:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 04:54:57 INFO - 'PWD': '/builds/slave/test-pgo', 04:54:57 INFO - 'SHELL': '/bin/bash', 04:54:57 INFO - 'SHLVL': '1', 04:54:57 INFO - 'TERM': 'linux', 04:54:57 INFO - 'TMOUT': '86400', 04:54:57 INFO - 'USER': 'cltbld', 04:54:57 INFO - 'XDG_SESSION_COOKIE': '70a720fcaf18edea6683c2dc000001ad-1448451981.625073-1036322318', 04:54:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:54:57 INFO - '_': '/tools/buildbot/bin/python'} 04:54:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:54:58 INFO - Downloading/unpacking jsonschema 04:54: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 04:54: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 04:54: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 04:54: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 04:54: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 04:54: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 04:54:59 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:54:59 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 04:54:59 INFO - Downloading/unpacking functools32 (from jsonschema) 04:54:59 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 04:54:59 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 04:54:59 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 04:54:59 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 04:54:59 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 04:54:59 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 04:54:59 INFO - Downloading functools32-3.2.3-2.tar.gz 04:55:00 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 04:55:00 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 04:55:00 INFO - warning: no files found matching '*.txt' 04:55:00 INFO - no previously-included directories found matching 'build' 04:55:00 INFO - no previously-included directories found matching 'dist' 04:55:00 INFO - no previously-included directories found matching '.git*' 04:55:00 INFO - Installing collected packages: jsonschema, functools32 04:55:00 INFO - Running setup.py install for functools32 04:55:00 INFO - warning: no files found matching '*.txt' 04:55:00 INFO - no previously-included directories found matching 'build' 04:55:00 INFO - no previously-included directories found matching 'dist' 04:55:00 INFO - no previously-included directories found matching '.git*' 04:55:00 INFO - Successfully installed jsonschema functools32 04:55:00 INFO - Cleaning up... 04:55:00 INFO - Return code: 0 04:55:00 INFO - Running post-action listener: _resource_record_post_action 04:55:00 INFO - Running post-action listener: _start_resource_monitoring 04:55:00 INFO - Starting resource monitoring. 04:55:00 INFO - ##### 04:55:00 INFO - ##### Running install step. 04:55:00 INFO - ##### 04:55:00 INFO - Running pre-action listener: _resource_record_pre_action 04:55:00 INFO - Running main action method: install 04:55:00 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 04:55:00 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 04:55:00 INFO - Reading from file tmpfile_stdout 04:55:00 INFO - Detecting whether we're running mozinstall >=1.0... 04:55:00 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 04:55:00 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 04:55:00 INFO - Reading from file tmpfile_stdout 04:55:00 INFO - Output received: 04:55:00 INFO - Usage: mozinstall [options] installer 04:55:00 INFO - Options: 04:55:00 INFO - -h, --help show this help message and exit 04:55:00 INFO - -d DEST, --destination=DEST 04:55:00 INFO - Directory to install application into. [default: 04:55:00 INFO - "/builds/slave/test-pgo"] 04:55:00 INFO - --app=APP Application being installed. [default: firefox] 04:55:00 INFO - mkdir: /builds/slave/test-pgo/build/application 04:55:00 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'] 04:55:00 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 04:55:15 INFO - Reading from file tmpfile_stdout 04:55:15 INFO - Output received: 04:55:15 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 04:55:15 INFO - Running post-action listener: _resource_record_post_action 04:55:15 INFO - ##### 04:55:15 INFO - ##### Running run-tests step. 04:55:15 INFO - ##### 04:55:15 INFO - Running pre-action listener: _resource_record_pre_action 04:55:15 INFO - Running main action method: run_tests 04:55:15 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 04:55:15 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 04:55:15 INFO - Python 2.7.3 04:55:15 INFO - Return code: 0 04:55:15 INFO - grabbing minidump binary from tooltool 04:55:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:55:15 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 0x17b3640>, '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 0x17b4540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17b49d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 04:55:15 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 04:55:15 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 04:55:15 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:55:15 INFO - Return code: 0 04:55:15 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 04:55:15 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 04:55:15 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 04:55:15 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 04:55:15 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 04:55:15 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/-6JexqjaSDWkrFJEiNXKMQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-015', '--webServer', 'localhost'] in /builds/slave/test-pgo/build 04:55:15 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --debug --branchName Fx-Team --suite dromaeojs --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/-6JexqjaSDWkrFJEiNXKMQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-015 --webServer localhost 04:55:15 INFO - Using env: {'DISPLAY': ':0', 04:55:15 INFO - 'HOME': '/home/cltbld', 04:55:15 INFO - 'LANG': 'en_US.UTF-8', 04:55:15 INFO - 'LANGUAGE': 'en_US:en', 04:55:15 INFO - 'LOGNAME': 'cltbld', 04:55:15 INFO - 'MAIL': '/var/mail/cltbld', 04:55:15 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 04:55:15 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 04:55:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:55:15 INFO - 'MOZ_NO_REMOTE': '1', 04:55:15 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 04:55:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:55:15 INFO - 'NO_EM_RESTART': '1', 04:55:15 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:55:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 04:55:15 INFO - 'PWD': '/builds/slave/test-pgo', 04:55:15 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 04:55:15 INFO - 'SHELL': '/bin/bash', 04:55:15 INFO - 'SHLVL': '1', 04:55:15 INFO - 'TERM': 'linux', 04:55:15 INFO - 'TMOUT': '86400', 04:55:15 INFO - 'USER': 'cltbld', 04:55:15 INFO - 'XDG_SESSION_COOKIE': '70a720fcaf18edea6683c2dc000001ad-1448451981.625073-1036322318', 04:55:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:55:15 INFO - '_': '/tools/buildbot/bin/python'} 04:55:15 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/-6JexqjaSDWkrFJEiNXKMQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-015', '--webServer', 'localhost'] with output_timeout 3600 04:55:15 INFO - mozversion INFO | application_buildid: 20151125023015 04:55:15 INFO - mozversion INFO | application_changeset: 80cc747d4e5e64f9e37e2eba98be52fcc772ad19 04:55:15 INFO - mozversion INFO | application_display_name: Nightly 04:55:15 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:55:15 INFO - mozversion INFO | application_name: Firefox 04:55:15 INFO - mozversion INFO | application_remotingname: firefox 04:55:15 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/fx-team 04:55:15 INFO - mozversion INFO | application_vendor: Mozilla 04:55:15 INFO - mozversion INFO | application_version: 45.0a1 04:55:15 INFO - mozversion INFO | platform_buildid: 20151125023015 04:55:15 INFO - mozversion INFO | platform_changeset: 80cc747d4e5e64f9e37e2eba98be52fcc772ad19 04:55:15 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/fx-team 04:55:15 INFO - mozversion INFO | platform_version: 45.0a1 04:55:15 INFO - 2015-11-25 04:55:15,527 DEBUG : using testdate: 1448456115 04:55:15 INFO - 2015-11-25 04:55:15,527 DEBUG : actual date: 1448456115 04:55:15 INFO - 2015-11-25 04:55:15,535 INFO : starting webserver on 'localhost:47894' 04:55:15 INFO - 2015-11-25 04:55:15,536 INFO : Starting test suite talos-linux64-ix-015 04:55:15 INFO - 2015-11-25 04:55:15,537 INFO : Starting test dromaeo_css 04:55:15 INFO - 2015-11-25 04:55:15,537 DEBUG : operating with platform_type : linux_ 04:55:15 INFO - 2015-11-25 04:55:15,537 INFO : Initialising browser for dromaeo_css test... 04:55:15 INFO - 2015-11-25 04:55:15,554 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmphFJExT/profile http://localhost:47894/getInfo.html 04:55:19 INFO - 2015-11-25 04:55:19,569 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 04:55:19 INFO - 2015-11-25 04:55:19,569 DEBUG : BROWSER_OUTPUT: colorDepth:24 04:55:19 INFO - 2015-11-25 04:55:19,570 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 04:55:19 INFO - 2015-11-25 04:55:19,570 DEBUG : BROWSER_OUTPUT: __metrics 04:55:19 INFO - 2015-11-25 04:55:19,747 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 04:55:20 INFO - 2015-11-25 04:55:20,924 INFO : Browser initialized. 04:55:20 INFO - 2015-11-25 04:55:20,925 INFO : Running cycle 1/1 for dromaeo_css test... 04:55:20 INFO - 2015-11-25 04:55:20,925 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmphFJExT/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 04:55:32 INFO - 2015-11-25 04:55:32,665 DEBUG : BROWSER_OUTPUT: RSS: Main: 139395072 04:55:32 INFO - 2015-11-25 04:55:32,666 DEBUG : BROWSER_OUTPUT: 04:56:24 INFO - 2015-11-25 04:56:24,235 DEBUG : BROWSER_OUTPUT: 1448456184232 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] 04:58:33 INFO - 2015-11-25 04:58:33,097 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:47894/tests/dromaeo/cssquery-dojo.html (next: http://localhost:47894/tests/dromaeo/cssquery-ext.html) 04:58:34 INFO - 2015-11-25 04:58:34,269 DEBUG : BROWSER_OUTPUT: RSS: Main: 266084352 04:58:34 INFO - 2015-11-25 04:58:34,269 DEBUG : BROWSER_OUTPUT: 05:01:36 INFO - 2015-11-25 05:01:36,600 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:47894/tests/dromaeo/cssquery-ext.html (next: http://localhost:47894/tests/dromaeo/cssquery-jquery.html) 05:01:37 INFO - 2015-11-25 05:01:37,166 DEBUG : BROWSER_OUTPUT: RSS: Main: 215281664 05:01:37 INFO - 2015-11-25 05:01:37,166 DEBUG : BROWSER_OUTPUT: 05:04:39 INFO - 2015-11-25 05:04:39,095 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:47894/tests/dromaeo/cssquery-jquery.html (next: http://localhost:47894/tests/dromaeo/cssquery-mootools.html) 05:04:39 INFO - 2015-11-25 05:04:39,661 DEBUG : BROWSER_OUTPUT: RSS: Main: 215441408 05:04:39 INFO - 2015-11-25 05:04:39,661 DEBUG : BROWSER_OUTPUT: 05:07:41 INFO - 2015-11-25 05:07:41,520 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:47894/tests/dromaeo/cssquery-mootools.html (next: http://localhost:47894/tests/dromaeo/cssquery-prototype.html) 05:07:42 INFO - 2015-11-25 05:07:42,081 DEBUG : BROWSER_OUTPUT: RSS: Main: 197095424 05:07:42 INFO - 2015-11-25 05:07:42,081 DEBUG : BROWSER_OUTPUT: 05:10:44 INFO - 2015-11-25 05:10:44,497 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:47894/tests/dromaeo/cssquery-prototype.html (next: http://localhost:47894/tests/dromaeo/cssquery-yui.html) 05:10:45 INFO - 2015-11-25 05:10:45,099 DEBUG : BROWSER_OUTPUT: RSS: Main: 205725696 05:10:45 INFO - 2015-11-25 05:10:45,099 DEBUG : BROWSER_OUTPUT: 05:13:47 INFO - 2015-11-25 05:13:47,499 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:47894/tests/dromaeo/cssquery-yui.html (next: http://localhost:47894/tests/dromaeo/cssquery-dojo.html) 05:13:47 INFO - 2015-11-25 05:13:47,749 DEBUG : BROWSER_OUTPUT: RSS: Main: 255852544 05:13:47 INFO - 2015-11-25 05:13:47,749 DEBUG : BROWSER_OUTPUT: 05:13:47 INFO - 2015-11-25 05:13:47,751 DEBUG : BROWSER_OUTPUT: __start_tp_report 05:13:47 INFO - 2015-11-25 05:13:47,751 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 05:13:47 INFO - 2015-11-25 05:13:47,751 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 05:13:47 INFO - 2015-11-25 05:13:47,751 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 05:13:47 INFO - 2015-11-25 05:13:47,753 DEBUG : BROWSER_OUTPUT: |0;dojo.html;3186.824724640145;3218.5333126696646;3250.0574833298347;3257.4136655402035;3290.9341813163737;5164.251183578379;5280.894382112356;5306.177542480917;5371.785128594852;5446.700431476273;5359.330083739533;5387.488188622075;5395.298611180541;5531.446855314466;5531.474509921551;4918.262260660894;4929.383827021622;4934.28452874333;4936.136176169156;4994.475580064095;4948.084604348189;5037.24441333801;5052.823151189709;5070.822521211759;5109.156989096795;4792.880177995543;4797.784099715521;4897;4984.800607975677;5000.32495613093;4918.409790825124;4924.482929292444;4933.210686290176;4953.653244272902;4964.280179373971;4886.902261954777;4903.754812259408;4918.114739346916;4921.311016457699;4963.751812409365;5017.623678224148;5128.282040514331;5155.819546315898;5259.737013149365;5300.655457395257;5732.197492351074;5749.9425005750245;5757.050086735725;5759.366469688331;5768.74040668171;5778;5778.5377169826315;5783.797567085174;5791.247137872049;5909;5516.227728117987;5516.9448305516835;5521.199426083235;5526.751296191641;5535.6955367454775;5911.822645320647;5965.821025369246;5966.642001479925;5971.552133589911;5973.492253158443;5533.916991245134;5654.604177707521;5656.038473459522;5707.1724599933605;5802.4197580241635;5835.387284335168;5843.211166492554;5846.473817356373;5847.532197424196;5852.4440178183;5807.94192058074;5819.592628515963;5820.563457740686;5824.330202026821;5827.329857066492;5593.356763972114;5727.828165155052;5757.88484230313;5887.4406931341455;5900.940990590039;4553.066621342617;4562.5665561771575;4566.406367172246;4583.564561366665;4599.9080018399445;4049.109195976939;4065.2479291331197;4070.3690927906223;4077.9796101019306;4105.158442519277;5278.736063196825;5393.2179833923865;5394.460553944653;5625.156226565966;5661.547076233974;5781.364049954502;5886.05823068307;5913.704314784243;5929.584929055011;5945.16767652529;5449.073657478239;5505.807296744675;5545.9722701387045;5553.333599968029;5581.274434323594;5081.085404627129;5132.307138536325;5134;5141.5886729061585;5145.794168233304;5743.052396354555;5865.178874957509;5872.588918775645;5930.140129681085;6032.607880487754;5837.328707198726;5888.528917686661;5898.085796701518;5907;5910.054391297544;6046.244219472566;6047.0627052806885;6051.273847138195;6061.3029501606115;6066.211392518944;5426.511613954605;5522;5565.38780734127;5736.598438109292;5849.53203743708;5788.507976822018;5824.242848429677;5842.1820945068575;5854.121881717606;5858.560607954506;5704.885902281848;5705.686187259741;5705.914411283751;5708.115242137475;5709.800156994485;5423.484768946943;5537.695426751407;5645.971770141287;5718.51392631631;5783.103618939072;5680.176374425768;5680.744366503434;5685.232493613309;5690.573207009574;5692.373838877637;5470.617056805985;5806;5814.331351894417;5821.38875418075;5826.592138550261;5451.046066938191;5622.943770562242;5692.48767610917;5704.9429505706075;5706.572007099401 05:13:47 INFO - 2015-11-25 05:13:47,754 DEBUG : BROWSER_OUTPUT: |1;ext.html;559.5439716630948;565.3385538919464;576.5848589015907;610.0391882784614;611.2023808929347;28872;40313.19373612529;41381.58618413815;41454.17091658169;41585.79207103968;36363.63636363635;36547.45178822313;36563.45154822673;36609;36664.266714665755;7551.811204719898;7659.234076592352;8854.867176992335;9045.412048216846;9046.502442365667;10608.57565697375;10790.352578845295;10848.728781780439;10852.348859068441;10879.456027198648;10516.789664206712;10602.098821600173;10618.097461715724;10619.25665203436;10631;7772.5725085120575;7953.005874265717;10266.435346055963;10704.46477676121;10949.124070074375;10429.322094063862;10559.155267578652;10568.630097946612;10572;10577.31247468912;40354.79822600898;40852.59147408517;40869.38695919564;40949.385759213634;40961.795191023855;3117.8441077946013;3151.621805383346;3161.162291992624;3172.74618030557;3710.5547334319785;27298.727012729818;27315.86342068277;27528.724712753017;27819;27994.580081298798;3815.7328986970924;3833.9616603833883;3886.436466712339;3921.137349783043;3933.2330195611867;262818;264391;264680;265555;268851;47515.28727069097;47703.76148119237;59120.40879591235;59412.40587594069;64045;61228;61425;61699.691501542206;61806.381936180966;61824.38175618276;15197.164155971528;15227;15363.385464581515;15403.152826594422;15417.537473875802;11491.482883270106;11542.942285288687;11544.653660390202;11550.133739969368;11553.884461155449;19886.50283742918;19964.800351996586;20302.492437689176;20334.796652033292;20365;7199.388052015533;7426.702931882773;7473.887891681629;7480.438967077491;7527.661255243527;895.6999405199331;928.8513837785922;970.5875003123786;1072.9624463143753;1124.7413094988199;28323.291917702223;28423.57364639532;28762.856185719356;28803.711962880523;28876.566851497246;1007.9294449388473;1023.534291897185;1058.3702696895334;1071.7642118733866;1129.943502824872;14634;14728.263586820616;14728.926355368369;14985.700285994219;15025;324437;325527;327544;327867;330150;51351;51499.48500514947;51549.226761598606;51652;51683.48316516787;1333.9933300333437;1339.0760375340983;1357.3077730357588;1359.6057143428295;1360.0751488987385;23827.285181444586;27270.046138234622;27399.315017124733;28696.139115825725;28721.856390717912;47232.52767472419;47710.76144619255;47869;47893.28160077532;47902.44926731955;274556;276809;277112;279626;280212;25055.373615659024;25655.486890261716;30830;31276;31518.212044699067;33732.66267337393;36857.63142368649;37492.62507374891;37617.24765504729;37787.62212377841;34754.30491390209;35471.46792798162;35606.465903011995;35944.460833087;36054.63945360618;33681.663183367855;33964.150896227795;34012.82993585016;34138.48792268168;34693;34857.128571784895;35191.648083518834;35529.289414212086;35669.46495802513;35747.10632234215;31230;32107;32355.51466728048;32478.188045299055;32566.837165814966;24967.750322496544;24971.500569988137;24984.125555605468;25384.619230711185;25472.235832925042 05:13:47 INFO - 2015-11-25 05:13:47,755 DEBUG : BROWSER_OUTPUT: |2;jquery.html;355.87544359474185;358.3406531981155;358.44262172322027;360.28843035005866;362.3568166504454;13420.731585368287;13828.861711382908;16131.274092665828;16307.83692163078;16939.576510587227;15989.280482378292;16006.279717412715;16335.509934701948;16339.428120015802;16351.918240408811;5178.093833579127;5427.83716488506;5443.292371991635;5446.564274858002;5449.04641687703;3917.1578110706337;4029.798510074499;5367.973160134214;5844.386339434362;6047.395260473962;5964.940350596482;5981.192539007222;5982.282126144847;6009.75960961561;6010.939890601104;5822.9417705822825;5934.228550288478;5952.077427998667;5956.195913551658;5957.314908785502;5244.239585260154;5344.706041167734;5350.117230656937;5367.2485851980755;5370.973145134289;20599;20842.166313347447;20948;20949.8952505238;21073;2225.2322948582714;2227.4542737029533;2260.796528312443;2339.9298021059394;2354.6468029795496;12629.621111366674;12754.234745915275;12851.22892626436;12949.798534249107;13316.334183290797;1735.7049301618756;1813.229377514551;1848.334599544163;1871.6911709567905;1889.9622007559772;61121.69439152776;61994.69002654958;62565.7486850265;63321.68339158321;63470;9266.907330926739;9400.858987115198;9585.376950498336;9589.712308630753;9649.855252171223;12465.813012804816;12470.875291247154;12483.687907802378;12486.937565312115;12501.312427816558;6977.616231107338;6993.615351155735;7067.505274630829;7081.433485321162;7105.71577136919;6586;6593.8351541210895;6599.142111525567;6626.304238055031;6660.800175994728;5586.888262234733;5614.1859430382365;5618.10110382345;5627.915581266284;5688.516476099495;1541.1985767401113;1635.1905806625796;1716.5794380376637;1761.5067781021335;1790.2033595050077;388.2119297825419;390.2838291734642;405.1047185719534;428.0753572283852;894.8970868350093;11020.724481888017;11113.11095112389;11487.36819474937;16963.406280780113;18030.90984545069;864.9264812491009;888.9688860889838;891.9777005574913;924.195949523905;939.1125386509683;9642.325037247325;9975.551100200508;10030.398176109456;10037;10039.498025098716;528550;530667;535610;539175;544596;77449.612751937;78550.21449785543;79839.60080199562;80216.59891700621;80891.59554202191;1132.886711328877;1137.590467431724;1151.1308961733837;1166.0962753865822;1168.1647621950347;15113.622159446102;15418.922905385401;15522.456714015407;15578;15755.291011904263;31987.36025279528;32030.839845800623;33202;35346;36308;46582.76708616571;47097.293540596234;47844;49386.753066234436;51483;9519.90480095218;9805.411675299505;9823;9887.209023278265;9929.503524823585;11745.823812642646;12753.872461275269;17674.646507070043;18229.45311640653;18292.72560911561;11120.61077862271;13879.861201387857;14027.929860350632;14307.284635768377;14466.396048711333;10556.947215263874;13498.59504214875;14150.858491414954;14179.078359906573;14482.348294326992;14215.50245741394;14465.927670362002;14522.85477145215;14635.634109146931;14662.706745865236;9433.528323583656;9443.575039123118;9614.855777163488;9627.277954153607;9698.448248280241;10044.598216071276;10127.898721012696;12723.936380318039;14034.368453419826;14569.125852448888 05:13:47 INFO - 2015-11-25 05:13:47,756 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1211.4851188245004;1668.4077152610823;1677.1362748184683;1698.0830351610139;1742.7908650961886;6094.847628809282;7249.710011599536;7468.850622987537;7471.290227428385;7481.513701609399;7141.964290178542;7300.12398512178;7330;7331.450141239402;7342.96328518358;1932.603816217672;1952.7949565295582;2160.0819651648067;2173.5978843913886;2206.5917805206086;2187.3109970359287;2189.0149432755243;2191.1564047841534;2191.616467118256;2194.0565556810566;2139.935801925937;2221.555688862226;2224.065892325219;2224.177054489841;2227.1982086448866;1902.4007437657162;1931.5847092875028;2141.6680414535695;2170.555036217572;2172.674098885164;2183.235867446397;2201.878896660683;2212.269950916194;2214.4242496950746;2224.043661225672;7260.600666963315;7306.817329566803;7311.086114235721;7330.816729581803;7331.120265568113;4432.357308190294;4535.841245556389;4544.818207271705;4545.499995000548;4547.272436410191;2917.8395188264635;3020.018493989462;3049.5578141169626;3091.0263267071027;3092.58250136231;933.6405483888684;938.3244064273712;942.4863449420014;952.0289304908954;960.7934294126726;10098.495075246281;10108.94945525275;10116.797664046751;10125.696229113139;10139.44233067181;3988.880333589997;4026.53694825093;4053.858114965962;4074.694397920168;4120.464339635828;8482.194191551793;8534.829303413897;8535.10381409943;8540.572971351408;8571.314294856396;4505.752183629932;4516.88707782308;4542.568455996675;4547.567981041796;4551.931721024187;4136.91726165475;4156.960759810047;4160.958390416057;4165.291900376943;4168.374743788456;3483.042163405033;3494.056604716712;3514.9630858896685;3518.630543792916;3544.680978711928;1148.311013391958;1157;1161.5992482593492;1166.4750862112085;1172.1150531348776;991.6182269826024;1196.5094311332311;1220.2068655374078;1272.8154417609394;1326.7014921642553;6009.338972712998;6252.937470625236;7046.154461464657;7059.329363710439;7061.152661680631;578.6296770067161;594.8156071617813;598.5690302981847;603.9063945088518;604.9274087109575;5331.81338653153;5378.677279363251;5400.081986062379;5404.972975135099;5414.891702166014;8439.66241350339;8697.826043479095;8794.120587941155;8805.295576353876;8813.911860881437;8717.433366831136;8725.650973961097;8739.737807865647;8743.781405464913;8751.64993400257;6666.833329166712;6696.397324240842;6959.269276725972;6972.581645101209;6976.5465244758925;6760.594364338155;6790.151231096113;6792.01515780219;6795.048693183057;6798.388145066968;7589.279018493235;7616.3906887447765;7706.961465192639;7724.961375193088;7752.496087754504;7710;7890.763277101696;8026.558539280396;8029.5583742894705;8047.678092876219;6399.456046236122;6476.158099447041;6521;6617.735290588515;6639.867202655823;7063.364297213276;7134.785956421316;7136.857262854817;7141.678624462015;7156.3917067047805;6650.168728908887;6682.431993280626;6685.565438246498;6755.966220168868;6835.521513494008;6474.741010359721;6483.222013358427;6518.413342799171;6525.2169739631545;6581.243157037002;6025.427584379477;6293.905591416224;6672.866542669217;6716;6734.73061077571;6160.291566469913;6243.37566243372;6306.527010474325;6308.337624549356;6314.715837787218;6341.90487142684;6382.234131904202;6391.073294372197;6392.9041064385;6397.904031439625 05:13:47 INFO - 2015-11-25 05:13:47,757 DEBUG : BROWSER_OUTPUT: |4;prototype.html;306.2069240666673;308.4201700802491;312.97809153359265;314.13612565445027;314.25991789336126;5892.764289428423;5947.375525569818;5983.9999999999945;5991.970040149804;6006.7897623583185;5655.5475561955045;5762;5821.941780582193;5903.085021821625;5913.113033045035;4487.057717879249;4512.819487220508;4522.570355816192;4533.2066888294585;4535.3877226574405;4526.343680166374;4538.795754191053;4542.9545704543025;4543.159515489645;4553.453585569736;4296.441462609872;4349.43457350544;4355.216061108999;4388.714733542325;4486.439195100613;4435.8225670973125;4436.511983681792;4447.799849006787;4454.48773391061;4455.866324010285;3955.20895820837;3956.1494278729924;3956.624120708528;3961.2473630010204;3963.801809909493;5609.074502707089;5617.915731264035;5622.9597524457695;5625.662460252398;5626.915596266059;5172.456892026321;5294.470552944713;5297.867553311159;5299.364076310867;5306.124489459235;6247.9062814057825;6267.811965641038;6271.717772700239;6272.839524687947;6273.56085074045;4424.889377765549;4425.513193548707;4428.778561071934;4437.801793515765;4441.777911104432;6391.744330226786;6460.515461340371;6523.249826269992;6554;6593.670316484205;4399.824007039682;4416.183006143874;4420.182266280748;4420.447444069491;4421.38100665907;4445.51099379068;4460.977695111568;4468.754218517947;4473.239549276631;4479.126570318822;5195.740212989335;5212.192110222922;5223.451537588575;5226.8954620908125;5227.320448341691;6219.253689557282;6372.107904893319;6376.458001069868;6376.744930202833;6379.106925030499;1609.5090997245718;1618.2232528386205;1619.983800162007;1623.0505154484758;1623.472371479274;1084.9403282819521;1096.8848270931596;1097.6487523992246;1098.2916019167592;1125.8198688209848;6126;6134.754609815557;6141.324454310112;6143.784967526115;6151.3541078187045;6535.901961470582;6552.868942621121;6555.901661475082;6556;6559.344065593403;5982.341942386334;5997.460228579449;6110.175126357974;6131.601445906091;6208.1308616793685;3532.8410221540094;3537.699295559855;3541.2740388220354;3550.662687044778;3563.679268865763;6756.662166891636;6758.155230596176;6789.049533065375;6791.728330866808;6818.352256535622;6625.768098116543;6737.326267373322;6764.154480689914;6776.390124888783;6798.912174052128;6820.522563420612;6832.487563432763;6837.247902730695;6839.897401538981;6841.828954276183;6614.636195009129;6617.933820661732;6619.900701489578;6624.668766561749;6624.8012559623285;6365.840853978688;6539.346065393423;6551.344865513601;6560.44236239925;6565.770198043046;6845.212800527804;6853.143357080365;6856;6858.3141685831015;6863.38229559342;4421.137878113737;4444.644428445781;4447.933281000723;4448.822047118079;4452.376667266521;6373.776917807854;6558.147440832661;6589.538732288694;6595.175603049619;6629.071929929717;6380.840478988062;6382.6170429774365;6389.361063893573;6396.42432181106;6400.615963042233;6417.679116044273;6433.131527243762;6433.742650293936;6438.742450302123;6440.066190402272;6164.229471316085;6311.810645680637;6314.715837787218;6315.27374351937;6317.526185536011;6456.709448074754;6469.967650161719;6470.967645161744;6473.935260647521;6475.481961443167;6313.936860631335;6320.5891617044745;6322.114903913363;6323.114763932961;6327.367263273636 05:13:47 INFO - 2015-11-25 05:13:47,758 DEBUG : BROWSER_OUTPUT: |5;yui.html;727.9162896266931;740.9777706668798;752.4206361101951;821.1952286758976;833.1918039501683;13987.930060349696;14098.859011409882;14154.43382264708;14226.928865355672;14253.14481131133;11446.656600301983;13235.272060036694;13426.261555614437;13448.596542103753;13461.93269033656;814.7637185216295;827.8509868223717;828.4904783558129;829.9958500207521;830.1698301698302;820.0323618130603;826.7437094500694;828.3745771942175;828.4739190613973;829.2826704900248;725.3979197266283;727.0911360799001;728.5919884864467;729.6205972894091;732.150705181989;718.6909628859588;724.8332883436839;725.6263024542338;726.3934614596818;726.9672864721074;545.0461692038932;546.9343678758535;549.4725063938623;549.8570371703346;551.35216121058;11823.586174483851;11947;11964.581239656658;11968.401579920968;11989.64031079069;10819.296745711503;10873.401962892038;10881.183911206612;10917.072048875854;10997.725056873562;9307.301952353533;9311;9430.481323527203;9442.527873606361;9656.517174141265;3436.6391528889358;3453.8791142309897;3487.581490221164;3504.4042512772635;3506.421440462321;47815;48124.27813582799;48244;48308.75845620749;48380.27429588559;10026.298159128792;10136.797264054678;10366.55411285543;10423.374597524173;10665.36007839532;17489.650206996044;17579.20893559793;17700;17704.91147544254;17708.9114554429;7255.129384473897;7350.117985841734;7353.963230183922;7701.1143718473095;7895.210478952059;3932.1545867638597;3963.742356746802;3975.1056012397557;4006.198760247962;4071.206114807643;2884.624998750149;2911.126662001391;2914.329704168053;2916.83957382346;2920.3575213453005;492.8422904670471;493.53854146373254;495.34366963773147;502.0887089931762;503.67764630636424;634.6699716147577;651.5883704349226;655.3151956205777;656.6322859198864;671.2347923367365;8111.75664730059;8151;8280.668773249123;8373.623186956602;8528.488290702579;580.7589850212115;582.9970850145722;586.8210195890294;595.4819307202762;612.2347066167291;3682.3739964206147;3715.145516531213;3801.6958643308467;3842.615738426135;3886.4947556817997;58803.70598146982;59869;59891.70054149701;60170;60188.69905650531;41673.58326416757;46242.30636540455;46367.304490432;54264.91470170575;54712.45287547153;47921.520784791705;48008.759956200694;48233.27650085252;49386;49601;8524.019737730241;8561.10108438605;8590.26982706452;8729.65081396737;8786.560671966248;34271.48592771061;34535.48196777;35414.29171416609;35464.29071418506;35535;42566;45202.321965171206;46826.76586617045;47481;47846;9444.291678124306;10109.494525273854;10313.174946004452;10338.12125969301;10449.216308777024;12065.939670301592;12346.506139754309;12573.371331433575;12835.807462887877;13049.412776424893;11000.559977600806;11131.554737810397;11151.944240278746;11630;12029.278243305429;10980.780384392427;11378.601748938747;11420.086393088699;11628.94185529067;11753.588624398106;10830.729231769268;11032.448377580928;11118.777624447304;11232.157588180755;11635.993554405728;8902.777430564287;9346.439213647203;9704.664532273107;9712.17446517054;9731.610735570497;8916.15296546827;9434.198093162158;9492.335536512377;9522.23822094217;9575 05:13:47 INFO - 2015-11-25 05:13:47,758 DEBUG : BROWSER_OUTPUT: __end_tp_report 05:13:47 INFO - 2015-11-25 05:13:47,758 DEBUG : BROWSER_OUTPUT: __start_cc_report 05:13:47 INFO - 2015-11-25 05:13:47,758 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,965 05:13:47 INFO - 2015-11-25 05:13:47,758 DEBUG : BROWSER_OUTPUT: __end_cc_report 05:13:47 INFO - 2015-11-25 05:13:47,758 DEBUG : BROWSER_OUTPUT: __startTimestamp1448457227750__endTimestamp 05:13:47 INFO - 2015-11-25 05:13:47,758 DEBUG : BROWSER_OUTPUT: 05:13:47 INFO - 2015-11-25 05:13:47,758 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 05:13:47 INFO - 2015-11-25 05:13:47,758 DEBUG : BROWSER_OUTPUT: Number of tests: 6 05:13:47 INFO - 2015-11-25 05:13:47,758 DEBUG : BROWSER_OUTPUT: 05:13:47 INFO - 2015-11-25 05:13:47,758 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:5406.17 Median:5622.94 stddev:590.98 (10.5%) stddev-sans-first:566.57 05:13:47 INFO - 2015-11-25 05:13:47,759 DEBUG : BROWSER_OUTPUT: Values: 3186.8 3218.5 3250.1 3257.4 3290.9 5164.3 5280.9 5306.2 5371.8 5446.7 5359.3 5387.5 5395.3 5531.4 5531.5 4918.3 4929.4 4934.3 4936.1 4994.5 4948.1 5037.2 5052.8 5070.8 5109.2 4792.9 4797.8 4897.0 4984.8 5000.3 4918.4 4924.5 4933.2 4953.7 4964.3 4886.9 4903.8 4918.1 4921.3 4963.8 5017.6 5128.3 5155.8 5259.7 5300.7 5732.2 5749.9 5757.1 5759.4 5768.7 5778.0 5778.5 5783.8 5791.2 5909.0 5516.2 5516.9 5521.2 5526.8 5535.7 5911.8 5965.8 5966.6 5971.6 5973.5 5533.9 5654.6 5656.0 5707.2 5802.4 5835.4 5843.2 5846.5 5847.5 5852.4 5807.9 5819.6 5820.6 5824.3 5827.3 5593.4 5727.8 5757.9 5887.4 5900.9 4553.1 4562.6 4566.4 4583.6 4599.9 4049.1 4065.2 4070.4 4078.0 4105.2 5278.7 5393.2 5394.5 5625.2 5661.5 5781.4 5886.1 5913.7 5929.6 5945.2 5449.1 5505.8 5546.0 5553.3 5581.3 5081.1 5132.3 5134.0 5141.6 5145.8 5743.1 5865.2 5872.6 5930.1 6032.6 5837.3 5888.5 5898.1 5907.0 5910.1 6046.2 6047.1 6051.3 6061.3 6066.2 5426.5 5522.0 5565.4 5736.6 5849.5 5788.5 5824.2 5842.2 5854.1 5858.6 5704.9 5705.7 5705.9 5708.1 5709.8 5423.5 5537.7 5646.0 5718.5 5783.1 5680.2 5680.7 5685.2 5690.6 5692.4 5470.6 5806.0 5814.3 5821.4 5826.6 5451.0 5622.9 5692.5 5704.9 5706.6 05:13:47 INFO - 2015-11-25 05:13:47,759 DEBUG : BROWSER_OUTPUT: 05:13:47 INFO - 2015-11-25 05:13:47,759 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:45671.18 Median:17639.87 stddev:76078.61 (431.3%) stddev-sans-first:76216.63 05:13:47 INFO - 2015-11-25 05:13:47,759 DEBUG : BROWSER_OUTPUT: Values: 559.5 565.3 576.6 610.0 611.2 28872.0 40313.2 41381.6 41454.2 41585.8 36363.6 36547.5 36563.5 36609.0 36664.3 7551.8 7659.2 8854.9 9045.4 9046.5 10608.6 10790.4 10848.7 10852.3 10879.5 10516.8 10602.1 10618.1 10619.3 10631.0 7772.6 7953.0 10266.4 10704.5 10949.1 10429.3 10559.2 10568.6 10572.0 10577.3 40354.8 40852.6 40869.4 40949.4 40961.8 3117.8 3151.6 3161.2 3172.7 3710.6 27298.7 27315.9 27528.7 27819.0 27994.6 3815.7 3834.0 3886.4 3921.1 3933.2 262818.0 264391.0 264680.0 265555.0 268851.0 47515.3 47703.8 59120.4 59412.4 64045.0 61228.0 61425.0 61699.7 61806.4 61824.4 15197.2 15227.0 15363.4 15403.2 15417.5 11491.5 11542.9 11544.7 11550.1 11553.9 19886.5 19964.8 20302.5 20334.8 20365.0 7199.4 7426.7 7473.9 7480.4 7527.7 895.7 928.9 970.6 1073.0 1124.7 28323.3 28423.6 28762.9 28803.7 28876.6 1007.9 1023.5 1058.4 1071.8 1129.9 14634.0 14728.3 14728.9 14985.7 15025.0 324437.0 325527.0 327544.0 327867.0 330150.0 51351.0 51499.5 51549.2 51652.0 51683.5 1334.0 1339.1 1357.3 1359.6 1360.1 23827.3 27270.0 27399.3 28696.1 28721.9 47232.5 47710.8 47869.0 47893.3 47902.4 274556.0 276809.0 277112.0 279626.0 280212.0 25055.4 25655.5 30830.0 31276.0 31518.2 33732.7 36857.6 37492.6 37617.2 37787.6 34754.3 35471.5 35606.5 35944.5 36054.6 33681.7 33964.2 34012.8 34138.5 34693.0 34857.1 35191.6 35529.3 35669.5 35747.1 31230.0 32107.0 32355.5 32478.2 32566.8 24967.8 24971.5 24984.1 25384.6 25472.2 05:13:47 INFO - 2015-11-25 05:13:47,759 DEBUG : BROWSER_OUTPUT: 05:13:47 INFO - 2015-11-25 05:13:47,759 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:28633.56 Median:361.32 stddev:87576.68 (24237.8%) stddev-sans-first:87796.62 05:13:47 INFO - 2015-11-25 05:13:47,760 DEBUG : BROWSER_OUTPUT: Values: 355.9 358.3 358.4 360.3 362.4 13420.7 13828.9 16131.3 16307.8 16939.6 15989.3 16006.3 16335.5 16339.4 16351.9 5178.1 5427.8 5443.3 5446.6 5449.0 3917.2 4029.8 5368.0 5844.4 6047.4 5964.9 5981.2 5982.3 6009.8 6010.9 5822.9 5934.2 5952.1 5956.2 5957.3 5244.2 5344.7 5350.1 5367.2 5371.0 20599.0 20842.2 20948.0 20949.9 21073.0 2225.2 2227.5 2260.8 2339.9 2354.6 12629.6 12754.2 12851.2 12949.8 13316.3 1735.7 1813.2 1848.3 1871.7 1890.0 61121.7 61994.7 62565.7 63321.7 63470.0 9266.9 9400.9 9585.4 9589.7 9649.9 12465.8 12470.9 12483.7 12486.9 12501.3 6977.6 6993.6 7067.5 7081.4 7105.7 6586.0 6593.8 6599.1 6626.3 6660.8 5586.9 5614.2 5618.1 5627.9 5688.5 1541.2 1635.2 1716.6 1761.5 1790.2 388.2 390.3 405.1 428.1 894.9 11020.7 11113.1 11487.4 16963.4 18030.9 864.9 889.0 892.0 924.2 939.1 9642.3 9975.6 10030.4 10037.0 10039.5 528550.0 530667.0 535610.0 539175.0 544596.0 77449.6 78550.2 79839.6 80216.6 80891.6 1132.9 1137.6 1151.1 1166.1 1168.2 15113.6 15418.9 15522.5 15578.0 15755.3 31987.4 32030.8 33202.0 35346.0 36308.0 46582.8 47097.3 47844.0 49386.8 51483.0 9519.9 9805.4 9823.0 9887.2 9929.5 11745.8 12753.9 17674.6 18229.5 18292.7 11120.6 13879.9 14027.9 14307.3 14466.4 10556.9 13498.6 14150.9 14179.1 14482.3 14215.5 14465.9 14522.9 14635.6 14662.7 9433.5 9443.6 9614.9 9627.3 9698.4 10044.6 10127.9 12723.9 14034.4 14569.1 05:13:47 INFO - 2015-11-25 05:13:47,760 DEBUG : BROWSER_OUTPUT: 05:13:47 INFO - 2015-11-25 05:13:47,760 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5146.66 Median:6300.22 stddev:2643.58 (42.0%) stddev-sans-first:2634.45 05:13:47 INFO - 2015-11-25 05:13:47,761 DEBUG : BROWSER_OUTPUT: Values: 1211.5 1668.4 1677.1 1698.1 1742.8 6094.8 7249.7 7468.9 7471.3 7481.5 7142.0 7300.1 7330.0 7331.5 7343.0 1932.6 1952.8 2160.1 2173.6 2206.6 2187.3 2189.0 2191.2 2191.6 2194.1 2139.9 2221.6 2224.1 2224.2 2227.2 1902.4 1931.6 2141.7 2170.6 2172.7 2183.2 2201.9 2212.3 2214.4 2224.0 7260.6 7306.8 7311.1 7330.8 7331.1 4432.4 4535.8 4544.8 4545.5 4547.3 2917.8 3020.0 3049.6 3091.0 3092.6 933.6 938.3 942.5 952.0 960.8 10098.5 10108.9 10116.8 10125.7 10139.4 3988.9 4026.5 4053.9 4074.7 4120.5 8482.2 8534.8 8535.1 8540.6 8571.3 4505.8 4516.9 4542.6 4547.6 4551.9 4136.9 4157.0 4161.0 4165.3 4168.4 3483.0 3494.1 3515.0 3518.6 3544.7 1148.3 1157.0 1161.6 1166.5 1172.1 991.6 1196.5 1220.2 1272.8 1326.7 6009.3 6252.9 7046.2 7059.3 7061.2 578.6 594.8 598.6 603.9 604.9 5331.8 5378.7 5400.1 5405.0 5414.9 8439.7 8697.8 8794.1 8805.3 8813.9 8717.4 8725.7 8739.7 8743.8 8751.6 6666.8 6696.4 6959.3 6972.6 6976.5 6760.6 6790.2 6792.0 6795.0 6798.4 7589.3 7616.4 7707.0 7725.0 7752.5 7710.0 7890.8 8026.6 8029.6 8047.7 6399.5 6476.2 6521.0 6617.7 6639.9 7063.4 7134.8 7136.9 7141.7 7156.4 6650.2 6682.4 6685.6 6756.0 6835.5 6474.7 6483.2 6518.4 6525.2 6581.2 6025.4 6293.9 6672.9 6716.0 6734.7 6160.3 6243.4 6306.5 6308.3 6314.7 6341.9 6382.2 6391.1 6392.9 6397.9 05:13:47 INFO - 2015-11-25 05:13:47,761 DEBUG : BROWSER_OUTPUT: 05:13:47 INFO - 2015-11-25 05:13:47,761 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:5298.59 Median:6002.12 stddev:1617.03 (26.9%) stddev-sans-first:1577.56 05:13:47 INFO - 2015-11-25 05:13:47,761 DEBUG : BROWSER_OUTPUT: Values: 306.2 308.4 313.0 314.1 314.3 5892.8 5947.4 5984.0 5992.0 6006.8 5655.5 5762.0 5821.9 5903.1 5913.1 4487.1 4512.8 4522.6 4533.2 4535.4 4526.3 4538.8 4543.0 4543.2 4553.5 4296.4 4349.4 4355.2 4388.7 4486.4 4435.8 4436.5 4447.8 4454.5 4455.9 3955.2 3956.1 3956.6 3961.2 3963.8 5609.1 5617.9 5623.0 5625.7 5626.9 5172.5 5294.5 5297.9 5299.4 5306.1 6247.9 6267.8 6271.7 6272.8 6273.6 4424.9 4425.5 4428.8 4437.8 4441.8 6391.7 6460.5 6523.2 6554.0 6593.7 4399.8 4416.2 4420.2 4420.4 4421.4 4445.5 4461.0 4468.8 4473.2 4479.1 5195.7 5212.2 5223.5 5226.9 5227.3 6219.3 6372.1 6376.5 6376.7 6379.1 1609.5 1618.2 1620.0 1623.1 1623.5 1084.9 1096.9 1097.6 1098.3 1125.8 6126.0 6134.8 6141.3 6143.8 6151.4 6535.9 6552.9 6555.9 6556.0 6559.3 5982.3 5997.5 6110.2 6131.6 6208.1 3532.8 3537.7 3541.3 3550.7 3563.7 6756.7 6758.2 6789.0 6791.7 6818.4 6625.8 6737.3 6764.2 6776.4 6798.9 6820.5 6832.5 6837.2 6839.9 6841.8 6614.6 6617.9 6619.9 6624.7 6624.8 6365.8 6539.3 6551.3 6560.4 6565.8 6845.2 6853.1 6856.0 6858.3 6863.4 4421.1 4444.6 4447.9 4448.8 4452.4 6373.8 6558.1 6589.5 6595.2 6629.1 6380.8 6382.6 6389.4 6396.4 6400.6 6417.7 6433.1 6433.7 6438.7 6440.1 6164.2 6311.8 6314.7 6315.3 6317.5 6456.7 6470.0 6471.0 6473.9 6475.5 6313.9 6320.6 6322.1 6323.1 6327.4 05:13:47 INFO - 2015-11-25 05:13:47,761 DEBUG : BROWSER_OUTPUT: 05:13:47 INFO - 2015-11-25 05:13:47,761 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:13721.71 Median:48178.78 stddev:16237.61 (33.7%) stddev-sans-first:16253.84 05:13:47 INFO - 2015-11-25 05:13:47,762 DEBUG : BROWSER_OUTPUT: Values: 727.9 741.0 752.4 821.2 833.2 13987.9 14098.9 14154.4 14226.9 14253.1 11446.7 13235.3 13426.3 13448.6 13461.9 814.8 827.9 828.5 830.0 830.2 820.0 826.7 828.4 828.5 829.3 725.4 727.1 728.6 729.6 732.2 718.7 724.8 725.6 726.4 727.0 545.0 546.9 549.5 549.9 551.4 11823.6 11947.0 11964.6 11968.4 11989.6 10819.3 10873.4 10881.2 10917.1 10997.7 9307.3 9311.0 9430.5 9442.5 9656.5 3436.6 3453.9 3487.6 3504.4 3506.4 47815.0 48124.3 48244.0 48308.8 48380.3 10026.3 10136.8 10366.6 10423.4 10665.4 17489.7 17579.2 17700.0 17704.9 17708.9 7255.1 7350.1 7354.0 7701.1 7895.2 3932.2 3963.7 3975.1 4006.2 4071.2 2884.6 2911.1 2914.3 2916.8 2920.4 492.8 493.5 495.3 502.1 503.7 634.7 651.6 655.3 656.6 671.2 8111.8 8151.0 8280.7 8373.6 8528.5 580.8 583.0 586.8 595.5 612.2 3682.4 3715.1 3801.7 3842.6 3886.5 58803.7 59869.0 59891.7 60170.0 60188.7 41673.6 46242.3 46367.3 54264.9 54712.5 47921.5 48008.8 48233.3 49386.0 49601.0 8524.0 8561.1 8590.3 8729.7 8786.6 34271.5 34535.5 35414.3 35464.3 35535.0 42566.0 45202.3 46826.8 47481.0 47846.0 9444.3 10109.5 10313.2 10338.1 10449.2 12065.9 12346.5 12573.4 12835.8 13049.4 11000.6 11131.6 11151.9 11630.0 12029.3 10980.8 11378.6 11420.1 11628.9 11753.6 10830.7 11032.4 11118.8 11232.2 11636.0 8902.8 9346.4 9704.7 9712.2 9731.6 8916.2 9434.2 9492.3 9522.2 9575.0 05:13:47 INFO - 2015-11-25 05:13:47,762 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 05:13:47 INFO - 2015-11-25 05:13:47,762 DEBUG : BROWSER_OUTPUT: 05:13:48 INFO - 2015-11-25 05:13:48,469 INFO : Browser exited with error code: 0 05:13:48 INFO - 2015-11-25 05:13:48,490 INFO : Completed test dromaeo_css (00:18:32) 05:13:48 INFO - 2015-11-25 05:13:48,491 INFO : Starting test kraken 05:13:48 INFO - 2015-11-25 05:13:48,491 DEBUG : operating with platform_type : linux_ 05:13:48 INFO - 2015-11-25 05:13:48,491 INFO : Initialising browser for kraken test... 05:13:48 INFO - 2015-11-25 05:13:48,497 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpI3lZkG/profile http://localhost:47894/getInfo.html 05:13:52 INFO - 2015-11-25 05:13:52,472 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 05:13:52 INFO - 2015-11-25 05:13:52,472 DEBUG : BROWSER_OUTPUT: colorDepth:24 05:13:52 INFO - 2015-11-25 05:13:52,472 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 05:13:52 INFO - 2015-11-25 05:13:52,472 DEBUG : BROWSER_OUTPUT: __metrics 05:13:52 INFO - 2015-11-25 05:13:52,621 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:13:53 INFO - 2015-11-25 05:13:53,867 INFO : Browser initialized. 05:13:53 INFO - 2015-11-25 05:13:53,867 INFO : Running cycle 1/1 for kraken test... 05:13:53 INFO - 2015-11-25 05:13:53,867 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpI3lZkG/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 05:14:05 INFO - 2015-11-25 05:14:05,563 DEBUG : BROWSER_OUTPUT: RSS: Main: 140951552 05:14:05 INFO - 2015-11-25 05:14:05,563 DEBUG : BROWSER_OUTPUT: 05:14:08 INFO - 2015-11-25 05:14:08,022 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:47894/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:47894/tests/kraken/driver.html?testName=audio-beat-detection) 05:14:08 INFO - 2015-11-25 05:14:08,604 DEBUG : BROWSER_OUTPUT: RSS: Main: 177127424 05:14:08 INFO - 2015-11-25 05:14:08,604 DEBUG : BROWSER_OUTPUT: 05:14:11 INFO - 2015-11-25 05:14:11,225 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:47894/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:47894/tests/kraken/driver.html?testName=audio-dft) 05:14:11 INFO - 2015-11-25 05:14:11,794 DEBUG : BROWSER_OUTPUT: RSS: Main: 165138432 05:14:11 INFO - 2015-11-25 05:14:11,795 DEBUG : BROWSER_OUTPUT: 05:14:14 INFO - 2015-11-25 05:14:14,699 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:47894/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:47894/tests/kraken/driver.html?testName=audio-fft) 05:14:15 INFO - 2015-11-25 05:14:15,260 DEBUG : BROWSER_OUTPUT: RSS: Main: 150163456 05:14:15 INFO - 2015-11-25 05:14:15,260 DEBUG : BROWSER_OUTPUT: 05:14:17 INFO - 2015-11-25 05:14:17,217 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:47894/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:47894/tests/kraken/driver.html?testName=audio-oscillator) 05:14:17 INFO - 2015-11-25 05:14:17,790 DEBUG : BROWSER_OUTPUT: RSS: Main: 153563136 05:14:17 INFO - 2015-11-25 05:14:17,790 DEBUG : BROWSER_OUTPUT: 05:14:19 INFO - 2015-11-25 05:14:19,965 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:47894/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:47894/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:14:20 INFO - 2015-11-25 05:14:20,526 DEBUG : BROWSER_OUTPUT: RSS: Main: 154238976 05:14:20 INFO - 2015-11-25 05:14:20,527 DEBUG : BROWSER_OUTPUT: 05:14:23 INFO - 2015-11-25 05:14:23,431 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:47894/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:47894/tests/kraken/driver.html?testName=imaging-darkroom) 05:14:24 INFO - 2015-11-25 05:14:24,004 DEBUG : BROWSER_OUTPUT: RSS: Main: 155164672 05:14:24 INFO - 2015-11-25 05:14:24,005 DEBUG : BROWSER_OUTPUT: 05:14:27 INFO - 2015-11-25 05:14:27,387 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:47894/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:47894/tests/kraken/driver.html?testName=imaging-desaturate) 05:14:27 INFO - 2015-11-25 05:14:27,969 DEBUG : BROWSER_OUTPUT: RSS: Main: 154689536 05:14:27 INFO - 2015-11-25 05:14:27,969 DEBUG : BROWSER_OUTPUT: 05:14:30 INFO - 2015-11-25 05:14:30,731 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:47894/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:47894/tests/kraken/driver.html?testName=json-parse-financial) 05:14:31 INFO - 2015-11-25 05:14:31,303 DEBUG : BROWSER_OUTPUT: RSS: Main: 156327936 05:14:31 INFO - 2015-11-25 05:14:31,304 DEBUG : BROWSER_OUTPUT: 05:14:32 INFO - 2015-11-25 05:14:32,844 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:47894/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:47894/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:14:33 INFO - 2015-11-25 05:14:33,405 DEBUG : BROWSER_OUTPUT: RSS: Main: 167145472 05:14:33 INFO - 2015-11-25 05:14:33,405 DEBUG : BROWSER_OUTPUT: 05:14:35 INFO - 2015-11-25 05:14:35,220 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:47894/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:47894/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:14:35 INFO - 2015-11-25 05:14:35,821 DEBUG : BROWSER_OUTPUT: RSS: Main: 165793792 05:14:35 INFO - 2015-11-25 05:14:35,822 DEBUG : BROWSER_OUTPUT: 05:14:37 INFO - 2015-11-25 05:14:37,854 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:47894/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:47894/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:14:38 INFO - 2015-11-25 05:14:38,428 DEBUG : BROWSER_OUTPUT: RSS: Main: 174096384 05:14:38 INFO - 2015-11-25 05:14:38,428 DEBUG : BROWSER_OUTPUT: 05:14:40 INFO - 2015-11-25 05:14:40,823 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:47894/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:47894/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:14:41 INFO - 2015-11-25 05:14:41,403 DEBUG : BROWSER_OUTPUT: RSS: Main: 181219328 05:14:41 INFO - 2015-11-25 05:14:41,404 DEBUG : BROWSER_OUTPUT: 05:14:43 INFO - 2015-11-25 05:14:43,960 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:47894/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:47894/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:14:44 INFO - 2015-11-25 05:14:44,533 DEBUG : BROWSER_OUTPUT: RSS: Main: 178573312 05:14:44 INFO - 2015-11-25 05:14:44,533 DEBUG : BROWSER_OUTPUT: 05:14:46 INFO - 2015-11-25 05:14:46,203 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:47894/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:47894/tests/kraken/driver.html?testName=ai-astar) 05:14:46 INFO - 2015-11-25 05:14:46,453 DEBUG : BROWSER_OUTPUT: RSS: Main: 236797952 05:14:46 INFO - 2015-11-25 05:14:46,453 DEBUG : BROWSER_OUTPUT: 05:14:46 INFO - 2015-11-25 05:14:46,454 DEBUG : BROWSER_OUTPUT: __start_tp_report 05:14:46 INFO - 2015-11-25 05:14:46,454 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 05:14:46 INFO - 2015-11-25 05:14:46,454 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 05:14:46 INFO - 2015-11-25 05:14:46,455 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 05:14:46 INFO - 2015-11-25 05:14:46,455 DEBUG : BROWSER_OUTPUT: |0;ai-astar;110;111;103;110;113;111;100;110;110;103 05:14:46 INFO - 2015-11-25 05:14:46,455 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;162;124;155;166;125;151;152;126;163;133 05:14:46 INFO - 2015-11-25 05:14:46,455 DEBUG : BROWSER_OUTPUT: |2;audio-dft;162;164;162;160;161;159;160;159;161;161 05:14:46 INFO - 2015-11-25 05:14:46,455 DEBUG : BROWSER_OUTPUT: |3;audio-fft;71;72;86;88;75;72;71;105;92;72 05:14:46 INFO - 2015-11-25 05:14:46,455 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;93;94;135;93;93;92;141;93;93;134 05:14:46 INFO - 2015-11-25 05:14:46,455 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;111;110;111;111;111;110;109;109;109;110 05:14:46 INFO - 2015-11-25 05:14:46,455 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;146;146;146;145;145;145;145;146;145;145 05:14:46 INFO - 2015-11-25 05:14:46,456 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;95;95;95;96;95;95;95;96;96;96 05:14:46 INFO - 2015-11-25 05:14:46,456 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;59;56;58;57;59;57;58;58;57;56 05:14:46 INFO - 2015-11-25 05:14:46,456 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;71;70;69;69;70;71;70;70;70;71 05:14:46 INFO - 2015-11-25 05:14:46,456 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;82;82;84;84;84;85;84;86;85;85 05:14:46 INFO - 2015-11-25 05:14:46,456 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;122;119;119;114;116;123;122;117;114;115 05:14:46 INFO - 2015-11-25 05:14:46,456 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;141;150;155;150;148;143;148;156;149;138 05:14:46 INFO - 2015-11-25 05:14:46,456 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;68;67;67;66;67;65;66;67;66;69 05:14:46 INFO - 2015-11-25 05:14:46,457 DEBUG : BROWSER_OUTPUT: __end_tp_report 05:14:46 INFO - 2015-11-25 05:14:46,457 DEBUG : BROWSER_OUTPUT: __start_cc_report 05:14:46 INFO - 2015-11-25 05:14:46,457 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,928 05:14:46 INFO - 2015-11-25 05:14:46,457 DEBUG : BROWSER_OUTPUT: __end_cc_report 05:14:46 INFO - 2015-11-25 05:14:46,457 DEBUG : BROWSER_OUTPUT: __startTimestamp1448457286453__endTimestamp 05:14:46 INFO - 2015-11-25 05:14:46,457 DEBUG : BROWSER_OUTPUT: 05:14:46 INFO - 2015-11-25 05:14:46,465 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 05:14:46 INFO - 2015-11-25 05:14:46,465 DEBUG : BROWSER_OUTPUT: Number of tests: 14 05:14:46 INFO - 2015-11-25 05:14:46,465 DEBUG : BROWSER_OUTPUT: 05:14:46 INFO - 2015-11-25 05:14:46,465 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:108.10 Median:110.00 stddev:4.38 (4.0%) stddev-sans-first:4.59 05:14:46 INFO - 2015-11-25 05:14:46,465 DEBUG : BROWSER_OUTPUT: Values: 110.0 111.0 103.0 110.0 113.0 111.0 100.0 110.0 110.0 103.0 05:14:46 INFO - 2015-11-25 05:14:46,466 DEBUG : BROWSER_OUTPUT: 05:14:46 INFO - 2015-11-25 05:14:46,466 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:145.70 Median:153.50 stddev:16.93 (11.0%) stddev-sans-first:16.90 05:14:46 INFO - 2015-11-25 05:14:46,466 DEBUG : BROWSER_OUTPUT: Values: 162.0 124.0 155.0 166.0 125.0 151.0 152.0 126.0 163.0 133.0 05:14:46 INFO - 2015-11-25 05:14:46,466 DEBUG : BROWSER_OUTPUT: 05:14:46 INFO - 2015-11-25 05:14:46,466 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:160.90 Median:161.00 stddev:1.52 (0.9%) stddev-sans-first:1.56 05:14:46 INFO - 2015-11-25 05:14:46,466 DEBUG : BROWSER_OUTPUT: Values: 162.0 164.0 162.0 160.0 161.0 159.0 160.0 159.0 161.0 161.0 05:14:46 INFO - 2015-11-25 05:14:46,466 DEBUG : BROWSER_OUTPUT: 05:14:46 INFO - 2015-11-25 05:14:46,467 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:80.40 Median:73.50 stddev:11.77 (16.0%) stddev-sans-first:11.98 05:14:46 INFO - 2015-11-25 05:14:46,467 DEBUG : BROWSER_OUTPUT: Values: 71.0 72.0 86.0 88.0 75.0 72.0 71.0 105.0 92.0 72.0 05:14:46 INFO - 2015-11-25 05:14:46,467 DEBUG : BROWSER_OUTPUT: 05:14:46 INFO - 2015-11-25 05:14:46,467 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:106.10 Median:93.00 stddev:21.17 (22.8%) stddev-sans-first:21.92 05:14:46 INFO - 2015-11-25 05:14:46,467 DEBUG : BROWSER_OUTPUT: Values: 93.0 94.0 135.0 93.0 93.0 92.0 141.0 93.0 93.0 134.0 05:14:46 INFO - 2015-11-25 05:14:46,467 DEBUG : BROWSER_OUTPUT: 05:14:46 INFO - 2015-11-25 05:14:46,468 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:110.10 Median:110.50 stddev:0.88 (0.8%) stddev-sans-first:0.87 05:14:46 INFO - 2015-11-25 05:14:46,468 DEBUG : BROWSER_OUTPUT: Values: 111.0 110.0 111.0 111.0 111.0 110.0 109.0 109.0 109.0 110.0 05:14:46 INFO - 2015-11-25 05:14:46,468 DEBUG : BROWSER_OUTPUT: 05:14:46 INFO - 2015-11-25 05:14:46,468 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:145.40 Median:145.50 stddev:0.52 (0.4%) stddev-sans-first:0.50 05:14:46 INFO - 2015-11-25 05:14:46,468 DEBUG : BROWSER_OUTPUT: Values: 146.0 146.0 146.0 145.0 145.0 145.0 145.0 146.0 145.0 145.0 05:14:46 INFO - 2015-11-25 05:14:46,469 DEBUG : BROWSER_OUTPUT: 05:14:46 INFO - 2015-11-25 05:14:46,469 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:95.40 Median:95.50 stddev:0.52 (0.5%) stddev-sans-first:0.53 05:14:46 INFO - 2015-11-25 05:14:46,469 DEBUG : BROWSER_OUTPUT: Values: 95.0 95.0 95.0 96.0 95.0 95.0 95.0 96.0 96.0 96.0 05:14:46 INFO - 2015-11-25 05:14:46,469 DEBUG : BROWSER_OUTPUT: 05:14:46 INFO - 2015-11-25 05:14:46,469 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:57.50 Median:58.00 stddev:1.08 (1.9%) stddev-sans-first:1.00 05:14:46 INFO - 2015-11-25 05:14:46,469 DEBUG : BROWSER_OUTPUT: Values: 59.0 56.0 58.0 57.0 59.0 57.0 58.0 58.0 57.0 56.0 05:14:46 INFO - 2015-11-25 05:14:46,469 DEBUG : BROWSER_OUTPUT: 05:14:46 INFO - 2015-11-25 05:14:46,470 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:70.10 Median:70.00 stddev:0.74 (1.1%) stddev-sans-first:0.71 05:14:46 INFO - 2015-11-25 05:14:46,470 DEBUG : BROWSER_OUTPUT: Values: 71.0 70.0 69.0 69.0 70.0 71.0 70.0 70.0 70.0 71.0 05:14:46 INFO - 2015-11-25 05:14:46,470 DEBUG : BROWSER_OUTPUT: 05:14:46 INFO - 2015-11-25 05:14:46,470 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:84.10 Median:84.50 stddev:1.29 (1.5%) stddev-sans-first:1.12 05:14:46 INFO - 2015-11-25 05:14:46,470 DEBUG : BROWSER_OUTPUT: Values: 82.0 82.0 84.0 84.0 84.0 85.0 84.0 86.0 85.0 85.0 05:14:46 INFO - 2015-11-25 05:14:46,470 DEBUG : BROWSER_OUTPUT: 05:14:46 INFO - 2015-11-25 05:14:46,470 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:118.10 Median:119.00 stddev:3.41 (2.9%) stddev-sans-first:3.32 05:14:46 INFO - 2015-11-25 05:14:46,470 DEBUG : BROWSER_OUTPUT: Values: 122.0 119.0 119.0 114.0 116.0 123.0 122.0 117.0 114.0 115.0 05:14:46 INFO - 2015-11-25 05:14:46,471 DEBUG : BROWSER_OUTPUT: 05:14:46 INFO - 2015-11-25 05:14:46,471 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:147.80 Median:149.50 stddev:5.73 (3.8%) stddev-sans-first:5.53 05:14:46 INFO - 2015-11-25 05:14:46,471 DEBUG : BROWSER_OUTPUT: Values: 141.0 150.0 155.0 150.0 148.0 143.0 148.0 156.0 149.0 138.0 05:14:46 INFO - 2015-11-25 05:14:46,471 DEBUG : BROWSER_OUTPUT: 05:14:46 INFO - 2015-11-25 05:14:46,471 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.80 Median:67.00 stddev:1.14 (1.7%) stddev-sans-first:1.12 05:14:46 INFO - 2015-11-25 05:14:46,471 DEBUG : BROWSER_OUTPUT: Values: 68.0 67.0 67.0 66.0 67.0 65.0 66.0 67.0 66.0 69.0 05:14:46 INFO - 2015-11-25 05:14:46,471 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 05:14:46 INFO - 2015-11-25 05:14:46,472 DEBUG : BROWSER_OUTPUT: 05:14:47 INFO - 2015-11-25 05:14:47,289 INFO : Browser exited with error code: 0 05:14:47 INFO - 2015-11-25 05:14:47,338 INFO : Completed test kraken (00:00:58) 05:14:47 INFO - 2015-11-25 05:14:47,338 INFO : Starting test v8_7 05:14:47 INFO - 2015-11-25 05:14:47,338 DEBUG : operating with platform_type : linux_ 05:14:47 INFO - 2015-11-25 05:14:47,339 INFO : Initialising browser for v8_7 test... 05:14:47 INFO - 2015-11-25 05:14:47,345 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpWT5OTA/profile http://localhost:47894/getInfo.html 05:14:51 INFO - 2015-11-25 05:14:51,425 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 05:14:51 INFO - 2015-11-25 05:14:51,426 DEBUG : BROWSER_OUTPUT: colorDepth:24 05:14:51 INFO - 2015-11-25 05:14:51,426 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 05:14:51 INFO - 2015-11-25 05:14:51,426 DEBUG : BROWSER_OUTPUT: __metrics 05:14:51 INFO - 2015-11-25 05:14:51,547 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:14:52 INFO - 2015-11-25 05:14:52,814 INFO : Browser initialized. 05:14:52 INFO - 2015-11-25 05:14:52,815 INFO : Running cycle 1/1 for v8_7 test... 05:14:52 INFO - 2015-11-25 05:14:52,815 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpWT5OTA/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 05:15:04 INFO - 2015-11-25 05:15:04,614 DEBUG : BROWSER_OUTPUT: RSS: Main: 139145216 05:15:04 INFO - 2015-11-25 05:15:04,615 DEBUG : BROWSER_OUTPUT: 05:15:26 INFO - 2015-11-25 05:15:26,062 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:47894/tests/v8_7/run.html (next: http://localhost:47894/tests/v8_7/run.html) 05:15:26 INFO - 2015-11-25 05:15:26,312 DEBUG : BROWSER_OUTPUT: RSS: Main: 515874816 05:15:26 INFO - 2015-11-25 05:15:26,312 DEBUG : BROWSER_OUTPUT: 05:15:26 INFO - 2015-11-25 05:15:26,312 DEBUG : BROWSER_OUTPUT: __start_tp_report 05:15:26 INFO - 2015-11-25 05:15:26,312 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 05:15:26 INFO - 2015-11-25 05:15:26,312 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 05:15:26 INFO - 2015-11-25 05:15:26,312 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 05:15:26 INFO - 2015-11-25 05:15:26,313 DEBUG : BROWSER_OUTPUT: |0;Richards;164.58196181698486 05:15:26 INFO - 2015-11-25 05:15:26,313 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;194.74196689386562 05:15:26 INFO - 2015-11-25 05:15:26,313 DEBUG : BROWSER_OUTPUT: |2;Encrypt;283.60748723766307 05:15:26 INFO - 2015-11-25 05:15:26,313 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5196.891191709845 05:15:26 INFO - 2015-11-25 05:15:26,313 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1978.2608695652175 05:15:26 INFO - 2015-11-25 05:15:26,313 DEBUG : BROWSER_OUTPUT: |5;Earley;794.2811755361398 05:15:26 INFO - 2015-11-25 05:15:26,313 DEBUG : BROWSER_OUTPUT: |6;Boyer;12292.682926829268 05:15:26 INFO - 2015-11-25 05:15:26,314 DEBUG : BROWSER_OUTPUT: |7;RegExp;25948.71794871795 05:15:26 INFO - 2015-11-25 05:15:26,314 DEBUG : BROWSER_OUTPUT: |8;Splay;615.3846153846154 05:15:26 INFO - 2015-11-25 05:15:26,314 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4864.077669902913 05:15:26 INFO - 2015-11-25 05:15:26,314 DEBUG : BROWSER_OUTPUT: __end_tp_report 05:15:26 INFO - 2015-11-25 05:15:26,314 DEBUG : BROWSER_OUTPUT: __startTimestamp1448457326311__endTimestamp 05:15:26 INFO - 2015-11-25 05:15:26,315 DEBUG : BROWSER_OUTPUT: 05:15:26 INFO - 2015-11-25 05:15:26,315 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 05:15:26 INFO - 2015-11-25 05:15:26,315 DEBUG : BROWSER_OUTPUT: Number of tests: 10 05:15:26 INFO - 2015-11-25 05:15:26,315 DEBUG : BROWSER_OUTPUT: 05:15:26 INFO - 2015-11-25 05:15:26,315 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:164.58 Median:164.58 stddev:0.00 (0.0%) 05:15:26 INFO - 2015-11-25 05:15:26,315 DEBUG : BROWSER_OUTPUT: Values: 164.6 05:15:26 INFO - 2015-11-25 05:15:26,316 DEBUG : BROWSER_OUTPUT: 05:15:26 INFO - 2015-11-25 05:15:26,316 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:194.74 Median:194.74 stddev:0.00 (0.0%) 05:15:26 INFO - 2015-11-25 05:15:26,317 DEBUG : BROWSER_OUTPUT: Values: 194.7 05:15:26 INFO - 2015-11-25 05:15:26,317 DEBUG : BROWSER_OUTPUT: 05:15:26 INFO - 2015-11-25 05:15:26,317 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:283.61 Median:283.61 stddev:0.00 (0.0%) 05:15:26 INFO - 2015-11-25 05:15:26,317 DEBUG : BROWSER_OUTPUT: Values: 283.6 05:15:26 INFO - 2015-11-25 05:15:26,318 DEBUG : BROWSER_OUTPUT: 05:15:26 INFO - 2015-11-25 05:15:26,318 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5196.89 Median:5196.89 stddev:0.00 (0.0%) 05:15:26 INFO - 2015-11-25 05:15:26,318 DEBUG : BROWSER_OUTPUT: Values: 5196.9 05:15:26 INFO - 2015-11-25 05:15:26,318 DEBUG : BROWSER_OUTPUT: 05:15:26 INFO - 2015-11-25 05:15:26,318 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1978.26 Median:1978.26 stddev:0.00 (0.0%) 05:15:26 INFO - 2015-11-25 05:15:26,318 DEBUG : BROWSER_OUTPUT: Values: 1978.3 05:15:26 INFO - 2015-11-25 05:15:26,318 DEBUG : BROWSER_OUTPUT: 05:15:26 INFO - 2015-11-25 05:15:26,319 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:794.28 Median:794.28 stddev:0.00 (0.0%) 05:15:26 INFO - 2015-11-25 05:15:26,319 DEBUG : BROWSER_OUTPUT: Values: 794.3 05:15:26 INFO - 2015-11-25 05:15:26,319 DEBUG : BROWSER_OUTPUT: 05:15:26 INFO - 2015-11-25 05:15:26,319 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:12292.68 Median:12292.68 stddev:0.00 (0.0%) 05:15:26 INFO - 2015-11-25 05:15:26,319 DEBUG : BROWSER_OUTPUT: Values: 12292.7 05:15:26 INFO - 2015-11-25 05:15:26,319 DEBUG : BROWSER_OUTPUT: 05:15:26 INFO - 2015-11-25 05:15:26,319 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:25948.72 Median:25948.72 stddev:0.00 (0.0%) 05:15:26 INFO - 2015-11-25 05:15:26,319 DEBUG : BROWSER_OUTPUT: Values: 25948.7 05:15:26 INFO - 2015-11-25 05:15:26,320 DEBUG : BROWSER_OUTPUT: 05:15:26 INFO - 2015-11-25 05:15:26,320 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:615.38 Median:615.38 stddev:0.00 (0.0%) 05:15:26 INFO - 2015-11-25 05:15:26,320 DEBUG : BROWSER_OUTPUT: Values: 615.4 05:15:26 INFO - 2015-11-25 05:15:26,320 DEBUG : BROWSER_OUTPUT: 05:15:26 INFO - 2015-11-25 05:15:26,320 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4864.08 Median:4864.08 stddev:0.00 (0.0%) 05:15:26 INFO - 2015-11-25 05:15:26,320 DEBUG : BROWSER_OUTPUT: Values: 4864.1 05:15:26 INFO - 2015-11-25 05:15:26,320 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 05:15:26 INFO - 2015-11-25 05:15:26,320 DEBUG : BROWSER_OUTPUT: 05:15:27 INFO - 2015-11-25 05:15:27,157 INFO : Browser exited with error code: 0 05:15:27 INFO - 2015-11-25 05:15:27,174 INFO : Completed test v8_7 (00:00:39) 05:15:27 INFO - 2015-11-25 05:15:27,292 INFO : Completed test suite (00:20:11) 05:15:27 INFO - 2015-11-25 05:15:27,293 DEBUG : Working with test: dromaeo_css 05:15:27 INFO - 2015-11-25 05:15:27,293 DEBUG : Generating results file: dromaeo_css 05:15:27 INFO - 2015-11-25 05:15:27,294 DEBUG : Working with test: kraken 05:15:27 INFO - 2015-11-25 05:15:27,294 DEBUG : Generating results file: kraken 05:15:27 INFO - 2015-11-25 05:15:27,294 INFO : javascript benchmark 05:15:27 INFO - 2015-11-25 05:15:27,295 DEBUG : Working with test: v8_7 05:15:27 INFO - 2015-11-25 05:15:27,295 DEBUG : Generating results file: v8_7 05:15:27 INFO - 2015-11-25 05:15:27,295 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 05:15:27 INFO - 2015-11-25 05:15:27,351 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,64,35]] 05:15:27 INFO - 2015-11-25 05:15:27,351 DEBUG : process_Request line: dromaeo_css 6869.94 graph.html#tests=[[72,64,35]] 05:15:27 INFO - 2015-11-25 05:15:27,351 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 05:15:27 INFO - 2015-11-25 05:15:27,477 DEBUG : process_Request line: kraken 1496.50 graph.html#tests=[[232,64,35]] 05:15:27 INFO - 2015-11-25 05:15:27,477 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 05:15:27 INFO - 2015-11-25 05:15:27,510 DEBUG : process_Request line: v8_7 19694.71 graph.html#tests=[[230,64,35]] 05:15:27 INFO - 2015-11-25 05:15:27,514 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3186.824724640145, 3218.5333126696646, 3250.0574833298347, 3257.4136655402035, 3290.9341813163737, 5164.251183578379, 5280.894382112356, 5306.177542480917, 5371.785128594852, 5446.700431476273, 5359.330083739533, 5387.488188622075, 5395.298611180541, 5531.446855314466, 5531.474509921551, 4918.262260660894, 4929.383827021622, 4934.28452874333, 4936.136176169156, 4994.475580064095, 4948.084604348189, 5037.24441333801, 5052.823151189709, 5070.822521211759, 5109.156989096795, 4792.880177995543, 4797.784099715521, 4897.0, 4984.800607975677, 5000.32495613093, 4918.409790825124, 4924.482929292444, 4933.210686290176, 4953.653244272902, 4964.280179373971, 4886.902261954777, 4903.754812259408, 4918.114739346916, 4921.311016457699, 4963.751812409365, 5017.623678224148, 5128.282040514331, 5155.819546315898, 5259.737013149365, 5300.655457395257, 5732.197492351074, 5749.9425005750245, 5757.050086735725, 5759.366469688331, 5768.74040668171, 5778.0, 5778.5377169826315, 5783.797567085174, 5791.247137872049, 5909.0, 5516.227728117987, 5516.9448305516835, 5521.199426083235, 5526.751296191641, 5535.6955367454775, 5911.822645320647, 5965.821025369246, 5966.642001479925, 5971.552133589911, 5973.492253158443, 5533.916991245134, 5654.604177707521, 5656.038473459522, 5707.1724599933605, 5802.4197580241635, 5835.387284335168, 5843.211166492554, 5846.473817356373, 5847.532197424196, 5852.4440178183, 5807.94192058074, 5819.592628515963, 5820.563457740686, 5824.330202026821, 5827.329857066492, 5593.356763972114, 5727.828165155052, 5757.88484230313, 5887.4406931341455, 5900.940990590039, 4553.066621342617, 4562.5665561771575, 4566.406367172246, 4583.564561366665, 4599.9080018399445, 4049.109195976939, 4065.2479291331197, 4070.3690927906223, 4077.9796101019306, 4105.158442519277, 5278.736063196825, 5393.2179833923865, 5394.460553944653, 5625.156226565966, 5661.547076233974, 5781.364049954502, 5886.05823068307, 5913.704314784243, 5929.584929055011, 5945.16767652529, 5449.073657478239, 5505.807296744675, 5545.9722701387045, 5553.333599968029, 5581.274434323594, 5081.085404627129, 5132.307138536325, 5134.0, 5141.5886729061585, 5145.794168233304, 5743.052396354555, 5865.178874957509, 5872.588918775645, 5930.140129681085, 6032.607880487754, 5837.328707198726, 5888.528917686661, 5898.085796701518, 5907.0, 5910.054391297544, 6046.244219472566, 6047.0627052806885, 6051.273847138195, 6061.3029501606115, 6066.211392518944, 5426.511613954605, 5522.0, 5565.38780734127, 5736.598438109292, 5849.53203743708, 5788.507976822018, 5824.242848429677, 5842.1820945068575, 5854.121881717606, 5858.560607954506, 5704.885902281848, 5705.686187259741, 5705.914411283751, 5708.115242137475, 5709.800156994485, 5423.484768946943, 5537.695426751407, 5645.971770141287, 5718.51392631631, 5783.103618939072, 5680.176374425768, 5680.744366503434, 5685.232493613309, 5690.573207009574, 5692.373838877637, 5470.617056805985, 5806.0, 5814.331351894417, 5821.38875418075, 5826.592138550261, 5451.046066938191, 5622.943770562242, 5692.48767610917, 5704.9429505706075, 5706.572007099401], "unit": "ms", "name": "dojo.html", "value": 5368.602018886648}, {"lowerIsBetter": false, "replicates": [559.5439716630948, 565.3385538919464, 576.5848589015907, 610.0391882784614, 611.2023808929347, 28872.0, 40313.19373612529, 41381.58618413815, 41454.17091658169, 41585.79207103968, 36363.63636363635, 36547.45178822313, 36563.45154822673, 36609.0, 36664.266714665755, 7551.811204719898, 7659.234076592352, 8854.867176992335, 9045.412048216846, 9046.502442365667, 10608.57565697375, 10790.352578845295, 10848.728781780439, 10852.348859068441, 10879.456027198648, 10516.789664206712, 10602.098821600173, 10618.097461715724, 10619.25665203436, 10631.0, 7772.5725085120575, 7953.005874265717, 10266.435346055963, 10704.46477676121, 10949.124070074375, 10429.322094063862, 10559.155267578652, 10568.630097946612, 10572.0, 10577.31247468912, 40354.79822600898, 40852.59147408517, 40869.38695919564, 40949.385759213634, 40961.795191023855, 3117.8441077946013, 3151.621805383346, 3161.162291992624, 3172.74618030557, 3710.5547334319785, 27298.727012729818, 27315.86342068277, 27528.724712753017, 27819.0, 27994.580081298798, 3815.7328986970924, 3833.9616603833883, 3886.436466712339, 3921.137349783043, 3933.2330195611867, 262818.0, 264391.0, 264680.0, 265555.0, 268851.0, 47515.28727069097, 47703.76148119237, 59120.40879591235, 59412.40587594069, 64045.0, 61228.0, 61425.0, 61699.691501542206, 61806.381936180966, 61824.38175618276, 15197.164155971528, 15227.0, 15363.385464581515, 15403.152826594422, 15417.537473875802, 11491.482883270106, 11542.942285288687, 11544.653660390202, 11550.133739969368, 11553.884461155449, 19886.50283742918, 19964.800351996586, 20302.492437689176, 20334.796652033292, 20365.0, 7199.388052015533, 7426.702931882773, 7473.887891681629, 7480.438967077491, 7527.661255243527, 895.6999405199331, 928.8513837785922, 970.5875003123786, 1072.9624463143753, 1124.7413094988199, 28323.291917702223, 28423.57364639532, 28762.856185719356, 28803.711962880523, 28876.566851497246, 1007.9294449388473, 1023.534291897185, 1058.3702696895334, 1071.7642118733866, 1129.943502824872, 14634.0, 14728.263586820616, 14728.926355368369, 14985.700285994219, 15025.0, 324437.0, 325527.0, 327544.0, 327867.0, 330150.0, 51351.0, 51499.48500514947, 51549.226761598606, 51652.0, 51683.48316516787, 1333.9933300333437, 1339.0760375340983, 1357.3077730357588, 1359.6057143428295, 1360.0751488987385, 23827.285181444586, 27270.046138234622, 27399.315017124733, 28696.139115825725, 28721.856390717912, 47232.52767472419, 47710.76144619255, 47869.0, 47893.28160077532, 47902.44926731955, 274556.0, 276809.0, 277112.0, 279626.0, 280212.0, 25055.373615659024, 25655.486890261716, 30830.0, 31276.0, 31518.212044699067, 33732.66267337393, 36857.63142368649, 37492.62507374891, 37617.24765504729, 37787.62212377841, 34754.30491390209, 35471.46792798162, 35606.465903011995, 35944.460833087, 36054.63945360618, 33681.663183367855, 33964.150896227795, 34012.82993585016, 34138.48792268168, 34693.0, 34857.128571784895, 35191.648083518834, 35529.289414212086, 35669.46495802513, 35747.10632234215, 31230.0, 32107.0, 32355.51466728048, 32478.188045299055, 32566.837165814966, 24967.750322496544, 24971.500569988137, 24984.125555605468, 25384.619230711185, 25472.235832925042], "unit": "ms", "name": "ext.html", "value": 18444.510039038527}, {"lowerIsBetter": false, "replicates": [355.87544359474185, 358.3406531981155, 358.44262172322027, 360.28843035005866, 362.3568166504454, 13420.731585368287, 13828.861711382908, 16131.274092665828, 16307.83692163078, 16939.576510587227, 15989.280482378292, 16006.279717412715, 16335.509934701948, 16339.428120015802, 16351.918240408811, 5178.093833579127, 5427.83716488506, 5443.292371991635, 5446.564274858002, 5449.04641687703, 3917.1578110706337, 4029.798510074499, 5367.973160134214, 5844.386339434362, 6047.395260473962, 5964.940350596482, 5981.192539007222, 5982.282126144847, 6009.75960961561, 6010.939890601104, 5822.9417705822825, 5934.228550288478, 5952.077427998667, 5956.195913551658, 5957.314908785502, 5244.239585260154, 5344.706041167734, 5350.117230656937, 5367.2485851980755, 5370.973145134289, 20599.0, 20842.166313347447, 20948.0, 20949.8952505238, 21073.0, 2225.2322948582714, 2227.4542737029533, 2260.796528312443, 2339.9298021059394, 2354.6468029795496, 12629.621111366674, 12754.234745915275, 12851.22892626436, 12949.798534249107, 13316.334183290797, 1735.7049301618756, 1813.229377514551, 1848.334599544163, 1871.6911709567905, 1889.9622007559772, 61121.69439152776, 61994.69002654958, 62565.7486850265, 63321.68339158321, 63470.0, 9266.907330926739, 9400.858987115198, 9585.376950498336, 9589.712308630753, 9649.855252171223, 12465.813012804816, 12470.875291247154, 12483.687907802378, 12486.937565312115, 12501.312427816558, 6977.616231107338, 6993.615351155735, 7067.505274630829, 7081.433485321162, 7105.71577136919, 6586.0, 6593.8351541210895, 6599.142111525567, 6626.304238055031, 6660.800175994728, 5586.888262234733, 5614.1859430382365, 5618.10110382345, 5627.915581266284, 5688.516476099495, 1541.1985767401113, 1635.1905806625796, 1716.5794380376637, 1761.5067781021335, 1790.2033595050077, 388.2119297825419, 390.2838291734642, 405.1047185719534, 428.0753572283852, 894.8970868350093, 11020.724481888017, 11113.11095112389, 11487.36819474937, 16963.406280780113, 18030.90984545069, 864.9264812491009, 888.9688860889838, 891.9777005574913, 924.195949523905, 939.1125386509683, 9642.325037247325, 9975.551100200508, 10030.398176109456, 10037.0, 10039.498025098716, 528550.0, 530667.0, 535610.0, 539175.0, 544596.0, 77449.612751937, 78550.21449785543, 79839.60080199562, 80216.59891700621, 80891.59554202191, 1132.886711328877, 1137.590467431724, 1151.1308961733837, 1166.0962753865822, 1168.1647621950347, 15113.622159446102, 15418.922905385401, 15522.456714015407, 15578.0, 15755.291011904263, 31987.36025279528, 32030.839845800623, 33202.0, 35346.0, 36308.0, 46582.76708616571, 47097.293540596234, 47844.0, 49386.753066234436, 51483.0, 9519.90480095218, 9805.411675299505, 9823.0, 9887.209023278265, 9929.503524823585, 11745.823812642646, 12753.872461275269, 17674.646507070043, 18229.45311640653, 18292.72560911561, 11120.61077862271, 13879.861201387857, 14027.929860350632, 14307.284635768377, 14466.396048711333, 10556.947215263874, 13498.59504214875, 14150.858491414954, 14179.078359906573, 14482.348294326992, 14215.50245741394, 14465.927670362002, 14522.85477145215, 14635.634109146931, 14662.706745865236, 9433.528323583656, 9443.575039123118, 9614.855777163488, 9627.277954153607, 9698.448248280241, 10044.598216071276, 10127.898721012696, 12723.936380318039, 14034.368453419826, 14569.125852448888], "unit": "ms", "name": "jquery.html", "value": 8684.210598279262}, {"lowerIsBetter": false, "replicates": [1211.4851188245004, 1668.4077152610823, 1677.1362748184683, 1698.0830351610139, 1742.7908650961886, 6094.847628809282, 7249.710011599536, 7468.850622987537, 7471.290227428385, 7481.513701609399, 7141.964290178542, 7300.12398512178, 7330.0, 7331.450141239402, 7342.96328518358, 1932.603816217672, 1952.7949565295582, 2160.0819651648067, 2173.5978843913886, 2206.5917805206086, 2187.3109970359287, 2189.0149432755243, 2191.1564047841534, 2191.616467118256, 2194.0565556810566, 2139.935801925937, 2221.555688862226, 2224.065892325219, 2224.177054489841, 2227.1982086448866, 1902.4007437657162, 1931.5847092875028, 2141.6680414535695, 2170.555036217572, 2172.674098885164, 2183.235867446397, 2201.878896660683, 2212.269950916194, 2214.4242496950746, 2224.043661225672, 7260.600666963315, 7306.817329566803, 7311.086114235721, 7330.816729581803, 7331.120265568113, 4432.357308190294, 4535.841245556389, 4544.818207271705, 4545.499995000548, 4547.272436410191, 2917.8395188264635, 3020.018493989462, 3049.5578141169626, 3091.0263267071027, 3092.58250136231, 933.6405483888684, 938.3244064273712, 942.4863449420014, 952.0289304908954, 960.7934294126726, 10098.495075246281, 10108.94945525275, 10116.797664046751, 10125.696229113139, 10139.44233067181, 3988.880333589997, 4026.53694825093, 4053.858114965962, 4074.694397920168, 4120.464339635828, 8482.194191551793, 8534.829303413897, 8535.10381409943, 8540.572971351408, 8571.314294856396, 4505.752183629932, 4516.88707782308, 4542.568455996675, 4547.567981041796, 4551.931721024187, 4136.91726165475, 4156.960759810047, 4160.958390416057, 4165.291900376943, 4168.374743788456, 3483.042163405033, 3494.056604716712, 3514.9630858896685, 3518.630543792916, 3544.680978711928, 1148.311013391958, 1157.0, 1161.5992482593492, 1166.4750862112085, 1172.1150531348776, 991.6182269826024, 1196.5094311332311, 1220.2068655374078, 1272.8154417609394, 1326.7014921642553, 6009.338972712998, 6252.937470625236, 7046.154461464657, 7059.329363710439, 7061.152661680631, 578.6296770067161, 594.8156071617813, 598.5690302981847, 603.9063945088518, 604.9274087109575, 5331.81338653153, 5378.677279363251, 5400.081986062379, 5404.972975135099, 5414.891702166014, 8439.66241350339, 8697.826043479095, 8794.120587941155, 8805.295576353876, 8813.911860881437, 8717.433366831136, 8725.650973961097, 8739.737807865647, 8743.781405464913, 8751.64993400257, 6666.833329166712, 6696.397324240842, 6959.269276725972, 6972.581645101209, 6976.5465244758925, 6760.594364338155, 6790.151231096113, 6792.01515780219, 6795.048693183057, 6798.388145066968, 7589.279018493235, 7616.3906887447765, 7706.961465192639, 7724.961375193088, 7752.496087754504, 7710.0, 7890.763277101696, 8026.558539280396, 8029.5583742894705, 8047.678092876219, 6399.456046236122, 6476.158099447041, 6521.0, 6617.735290588515, 6639.867202655823, 7063.364297213276, 7134.785956421316, 7136.857262854817, 7141.678624462015, 7156.3917067047805, 6650.168728908887, 6682.431993280626, 6685.565438246498, 6755.966220168868, 6835.521513494008, 6474.741010359721, 6483.222013358427, 6518.413342799171, 6525.2169739631545, 6581.243157037002, 6025.427584379477, 6293.905591416224, 6672.866542669217, 6716.0, 6734.73061077571, 6160.291566469913, 6243.37566243372, 6306.527010474325, 6308.337624549356, 6314.715837787218, 6341.90487142684, 6382.234131904202, 6391.073294372197, 6392.9041064385, 6397.904031439625], "unit": "ms", "name": "mootools.html", "value": 4206.184010508791}, {"lowerIsBetter": false, "replicates": [306.2069240666673, 308.4201700802491, 312.97809153359265, 314.13612565445027, 314.25991789336126, 5892.764289428423, 5947.375525569818, 5983.9999999999945, 5991.970040149804, 6006.7897623583185, 5655.5475561955045, 5762.0, 5821.941780582193, 5903.085021821625, 5913.113033045035, 4487.057717879249, 4512.819487220508, 4522.570355816192, 4533.2066888294585, 4535.3877226574405, 4526.343680166374, 4538.795754191053, 4542.9545704543025, 4543.159515489645, 4553.453585569736, 4296.441462609872, 4349.43457350544, 4355.216061108999, 4388.714733542325, 4486.439195100613, 4435.8225670973125, 4436.511983681792, 4447.799849006787, 4454.48773391061, 4455.866324010285, 3955.20895820837, 3956.1494278729924, 3956.624120708528, 3961.2473630010204, 3963.801809909493, 5609.074502707089, 5617.915731264035, 5622.9597524457695, 5625.662460252398, 5626.915596266059, 5172.456892026321, 5294.470552944713, 5297.867553311159, 5299.364076310867, 5306.124489459235, 6247.9062814057825, 6267.811965641038, 6271.717772700239, 6272.839524687947, 6273.56085074045, 4424.889377765549, 4425.513193548707, 4428.778561071934, 4437.801793515765, 4441.777911104432, 6391.744330226786, 6460.515461340371, 6523.249826269992, 6554.0, 6593.670316484205, 4399.824007039682, 4416.183006143874, 4420.182266280748, 4420.447444069491, 4421.38100665907, 4445.51099379068, 4460.977695111568, 4468.754218517947, 4473.239549276631, 4479.126570318822, 5195.740212989335, 5212.192110222922, 5223.451537588575, 5226.8954620908125, 5227.320448341691, 6219.253689557282, 6372.107904893319, 6376.458001069868, 6376.744930202833, 6379.106925030499, 1609.5090997245718, 1618.2232528386205, 1619.983800162007, 1623.0505154484758, 1623.472371479274, 1084.9403282819521, 1096.8848270931596, 1097.6487523992246, 1098.2916019167592, 1125.8198688209848, 6126.0, 6134.754609815557, 6141.324454310112, 6143.784967526115, 6151.3541078187045, 6535.901961470582, 6552.868942621121, 6555.901661475082, 6556.0, 6559.344065593403, 5982.341942386334, 5997.460228579449, 6110.175126357974, 6131.601445906091, 6208.1308616793685, 3532.8410221540094, 3537.699295559855, 3541.2740388220354, 3550.662687044778, 3563.679268865763, 6756.662166891636, 6758.155230596176, 6789.049533065375, 6791.728330866808, 6818.352256535622, 6625.768098116543, 6737.326267373322, 6764.154480689914, 6776.390124888783, 6798.912174052128, 6820.522563420612, 6832.487563432763, 6837.247902730695, 6839.897401538981, 6841.828954276183, 6614.636195009129, 6617.933820661732, 6619.900701489578, 6624.668766561749, 6624.8012559623285, 6365.840853978688, 6539.346065393423, 6551.344865513601, 6560.44236239925, 6565.770198043046, 6845.212800527804, 6853.143357080365, 6856.0, 6858.3141685831015, 6863.38229559342, 4421.137878113737, 4444.644428445781, 4447.933281000723, 4448.822047118079, 4452.376667266521, 6373.776917807854, 6558.147440832661, 6589.538732288694, 6595.175603049619, 6629.071929929717, 6380.840478988062, 6382.6170429774365, 6389.361063893573, 6396.42432181106, 6400.615963042233, 6417.679116044273, 6433.131527243762, 6433.742650293936, 6438.742450302123, 6440.066190402272, 6164.229471316085, 6311.810645680637, 6314.715837787218, 6315.27374351937, 6317.526185536011, 6456.709448074754, 6469.967650161719, 6470.967645161744, 6473.935260647521, 6475.481961443167, 6313.936860631335, 6320.5891617044745, 6322.114903913363, 6323.114763932961, 6327.367263273636], "unit": "ms", "name": "prototype.html", "value": 4767.714160982019}, {"lowerIsBetter": false, "replicates": [727.9162896266931, 740.9777706668798, 752.4206361101951, 821.1952286758976, 833.1918039501683, 13987.930060349696, 14098.859011409882, 14154.43382264708, 14226.928865355672, 14253.14481131133, 11446.656600301983, 13235.272060036694, 13426.261555614437, 13448.596542103753, 13461.93269033656, 814.7637185216295, 827.8509868223717, 828.4904783558129, 829.9958500207521, 830.1698301698302, 820.0323618130603, 826.7437094500694, 828.3745771942175, 828.4739190613973, 829.2826704900248, 725.3979197266283, 727.0911360799001, 728.5919884864467, 729.6205972894091, 732.150705181989, 718.6909628859588, 724.8332883436839, 725.6263024542338, 726.3934614596818, 726.9672864721074, 545.0461692038932, 546.9343678758535, 549.4725063938623, 549.8570371703346, 551.35216121058, 11823.586174483851, 11947.0, 11964.581239656658, 11968.401579920968, 11989.64031079069, 10819.296745711503, 10873.401962892038, 10881.183911206612, 10917.072048875854, 10997.725056873562, 9307.301952353533, 9311.0, 9430.481323527203, 9442.527873606361, 9656.517174141265, 3436.6391528889358, 3453.8791142309897, 3487.581490221164, 3504.4042512772635, 3506.421440462321, 47815.0, 48124.27813582799, 48244.0, 48308.75845620749, 48380.27429588559, 10026.298159128792, 10136.797264054678, 10366.55411285543, 10423.374597524173, 10665.36007839532, 17489.650206996044, 17579.20893559793, 17700.0, 17704.91147544254, 17708.9114554429, 7255.129384473897, 7350.117985841734, 7353.963230183922, 7701.1143718473095, 7895.210478952059, 3932.1545867638597, 3963.742356746802, 3975.1056012397557, 4006.198760247962, 4071.206114807643, 2884.624998750149, 2911.126662001391, 2914.329704168053, 2916.83957382346, 2920.3575213453005, 492.8422904670471, 493.53854146373254, 495.34366963773147, 502.0887089931762, 503.67764630636424, 634.6699716147577, 651.5883704349226, 655.3151956205777, 656.6322859198864, 671.2347923367365, 8111.75664730059, 8151.0, 8280.668773249123, 8373.623186956602, 8528.488290702579, 580.7589850212115, 582.9970850145722, 586.8210195890294, 595.4819307202762, 612.2347066167291, 3682.3739964206147, 3715.145516531213, 3801.6958643308467, 3842.615738426135, 3886.4947556817997, 58803.70598146982, 59869.0, 59891.70054149701, 60170.0, 60188.69905650531, 41673.58326416757, 46242.30636540455, 46367.304490432, 54264.91470170575, 54712.45287547153, 47921.520784791705, 48008.759956200694, 48233.27650085252, 49386.0, 49601.0, 8524.019737730241, 8561.10108438605, 8590.26982706452, 8729.65081396737, 8786.560671966248, 34271.48592771061, 34535.48196777, 35414.29171416609, 35464.29071418506, 35535.0, 42566.0, 45202.321965171206, 46826.76586617045, 47481.0, 47846.0, 9444.291678124306, 10109.494525273854, 10313.174946004452, 10338.12125969301, 10449.216308777024, 12065.939670301592, 12346.506139754309, 12573.371331433575, 12835.807462887877, 13049.412776424893, 11000.559977600806, 11131.554737810397, 11151.944240278746, 11630.0, 12029.278243305429, 10980.780384392427, 11378.601748938747, 11420.086393088699, 11628.94185529067, 11753.588624398106, 10830.729231769268, 11032.448377580928, 11118.777624447304, 11232.157588180755, 11635.993554405728, 8902.777430564287, 9346.439213647203, 9704.664532273107, 9712.17446517054, 9731.610735570497, 8916.15296546827, 9434.198093162158, 9492.335536512377, 9522.23822094217, 9575.0], "unit": "ms", "name": "yui.html", "value": 6095.648304241041}], "name": "dromaeo_css"}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [110.0, 111.0, 103.0, 110.0, 113.0, 111.0, 100.0, 110.0, 110.0, 103.0], "unit": "ms", "name": "ai-astar", "value": 108.1}, {"lowerIsBetter": true, "replicates": [162.0, 124.0, 155.0, 166.0, 125.0, 151.0, 152.0, 126.0, 163.0, 133.0], "unit": "ms", "name": "audio-beat-detection", "value": 145.7}, {"lowerIsBetter": true, "replicates": [162.0, 164.0, 162.0, 160.0, 161.0, 159.0, 160.0, 159.0, 161.0, 161.0], "unit": "ms", "name": "audio-dft", "value": 160.9}, {"lowerIsBetter": true, "replicates": [71.0, 72.0, 86.0, 88.0, 75.0, 72.0, 71.0, 105.0, 92.0, 72.0], "unit": "ms", "name": "audio-fft", "value": 80.4}, {"lowerIsBetter": true, "replicates": [93.0, 94.0, 135.0, 93.0, 93.0, 92.0, 141.0, 93.0, 93.0, 134.0], "unit": "ms", "name": "audio-oscillator", "value": 106.1}, {"lowerIsBetter": true, "replicates": [111.0, 110.0, 111.0, 111.0, 111.0, 110.0, 109.0, 109.0, 109.0, 110.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 110.1}, {"lowerIsBetter": true, "replicates": [146.0, 146.0, 146.0, 145.0, 145.0, 145.0, 145.0, 146.0, 145.0, 145.0], "unit": "ms", "name": "imaging-darkroom", "value": 145.4}, {"lowerIsBetter": true, "replicates": [95.0, 95.0, 95.0, 96.0, 95.0, 95.0, 95.0, 96.0, 96.0, 96.0], "unit": "ms", "name": "imaging-desaturate", "value": 95.4}, {"lowerIsBetter": true, "replicates": [59.0, 56.0, 58.0, 57.0, 59.0, 57.0, 58.0, 58.0, 57.0, 56.0], "unit": "ms", "name": "json-parse-financial", "value": 57.5}, {"lowerIsBetter": true, "replicates": [71.0, 70.0, 69.0, 69.0, 70.0, 71.0, 70.0, 70.0, 70.0, 71.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 70.1}, {"lowerIsBetter": true, "replicates": [82.0, 82.0, 84.0, 84.0, 84.0, 85.0, 84.0, 86.0, 85.0, 85.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 84.1}, {"lowerIsBetter": true, "replicates": [122.0, 119.0, 119.0, 114.0, 116.0, 123.0, 122.0, 117.0, 114.0, 115.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 118.1}, {"lowerIsBetter": true, "replicates": [141.0, 150.0, 155.0, 150.0, 148.0, 143.0, 148.0, 156.0, 149.0, 138.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 147.8}, {"lowerIsBetter": true, "replicates": [68.0, 67.0, 67.0, 66.0, 67.0, 65.0, 66.0, 67.0, 66.0, 69.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 66.8}], "name": "kraken"}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [164.58196181698486], "unit": "score", "name": "Richards", "value": 214.4949520000001}, {"lowerIsBetter": false, "replicates": [194.74196689386562], "unit": "score", "name": "DeltaBlue", "value": 339.51593000000014}, {"lowerIsBetter": false, "replicates": [283.60748723766307], "unit": "score", "name": "Encrypt", "value": 938.5542060000004}, {"lowerIsBetter": false, "replicates": [5196.891191709845], "unit": "score", "name": "Decrypt", "value": 51.219275174476564}, {"lowerIsBetter": false, "replicates": [1978.2608695652175], "unit": "score", "name": "RayTrace", "value": 374.06037362637363}, {"lowerIsBetter": false, "replicates": [794.2811755361398], "unit": "score", "name": "Earley", "value": 839.0769169999999}, {"lowerIsBetter": false, "replicates": [12292.682926829268], "unit": "score", "name": "Boyer", "value": 54.21623611111113}, {"lowerIsBetter": false, "replicates": [25948.71794871795], "unit": "score", "name": "RegExp", "value": 35.107129446640336}, {"lowerIsBetter": false, "replicates": [615.3846153846154], "unit": "score", "name": "Splay", "value": 132.42287499999998}, {"lowerIsBetter": false, "replicates": [4864.077669902913], "unit": "score", "name": "NavierStokes", "value": 305.0938123752493}], "name": "v8_7"}]} 05:15:27 INFO - RETURN: dromaeo_css: 6869.94 05:15:27 INFO - RETURN: kraken: 1496.50 05:15:27 INFO - RETURN: v8_7: 19694.71 05:15:27 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,64,35]]", "result": "19694.71"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,35]]", "result": "1496.50"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,35]]", "result": "6869.94"}}} 05:15:27 INFO - Return code: 0 05:15:27 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 05:15:27 INFO - # TBPL SUCCESS # 05:15:27 INFO - Running post-action listener: _resource_record_post_action 05:15:27 INFO - Running post-run listener: _resource_record_post_run 05:15:28 INFO - Total resource usage - Wall time: 1227s; CPU: 13.0%; Read bytes: 221184; Write bytes: 503967744; Read time: 336; Write time: 610840 05:15:28 INFO - install - Wall time: 15s; CPU: 15.0%; Read bytes: 4096; Write bytes: 244736000; Read time: 180; Write time: 437844 05:15:28 INFO - run-tests - Wall time: 1212s; CPU: 13.0%; Read bytes: 217088; Write bytes: 258949120; Read time: 156; Write time: 172964 05:15:28 INFO - Running post-run listener: _upload_blobber_files 05:15:28 INFO - Blob upload gear active. 05:15:28 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 05:15:28 INFO - Copying logs to upload dir... 05:15:28 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1263.393092 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 3 secs) (at 2015-11-25 05:15:28.558367) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-25 05:15:28.561540) ========= bash -c 'for file in `ls -1`; do cat $file; done' in dir /builds/slave/test-pgo/properties (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'for file in `ls -1`; do cat $file; done'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test-pgo/properties SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=70a720fcaf18edea6683c2dc000001ad-1448451981.625073-1036322318 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/-6JexqjaSDWkrFJEiNXKMQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.010084 build_url: 'https://queue.taskcluster.net/v1/task/-6JexqjaSDWkrFJEiNXKMQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2' ========= master_lag: 0.04 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-25 05:15:28.613898) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-25 05:15:28.614292) ========= rm -f oauth.txt in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-f', 'oauth.txt'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=70a720fcaf18edea6683c2dc000001ad-1448451981.625073-1036322318 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004539 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-25 05:15:28.664021) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-25 05:15:28.664380) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-25 05:15:28.664690) ========= ========= Total master_lag: 0.27 =========