builder: b2g-inbound_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-016 starttime: 1448020711.29 results: success (0) buildid: 20151120023024 builduid: 1da4e365967c40678ee31dfe1fcfab57 revision: 0c5552dc5878391f8597e3d62d804cf532b0272d ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-11-20 03:58:31.294331) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-11-20 03:58:31.294782) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-20 03:58:31.295079) ========= 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=d6a7e047ef025f707024e163000001c3-1448020680.460833-619040387 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.004633 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.04 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-20 03:58:31.340319) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-20 03:58:31.340673) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-20 03:58:31.723280) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-20 03:58:31.723551) ========= 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=d6a7e047ef025f707024e163000001c3-1448020680.460833-619040387 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004594 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-20 03:58:31.775852) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-20 03:58:31.779294) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-20 03:58:31.779741) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-20 03:58:31.780020) ========= 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=d6a7e047ef025f707024e163000001c3-1448020680.460833-619040387 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-11-20 03:58:31-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 222M=0s 2015-11-20 03:58:32 (222 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.107757 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-20 03:58:31.900606) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-20 03:58:31.900886) ========= 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=d6a7e047ef025f707024e163000001c3-1448020680.460833-619040387 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018654 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-20 03:58:31.959690) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-11-20 03:58:31.960243) ========= bash -c 'python archiver_client.py mozharness --repo integration/b2g-inbound --rev 0c5552dc5878391f8597e3d62d804cf532b0272d --destination scripts --debug' in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/b2g-inbound --rev 0c5552dc5878391f8597e3d62d804cf532b0272d --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=d6a7e047ef025f707024e163000001c3-1448020680.460833-619040387 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-11-20 03:58:32,143 truncating revision to first 12 chars 2015-11-20 03:58:32,143 Setting DEBUG logging. 2015-11-20 03:58:32,143 attempt 1/10 2015-11-20 03:58:32,143 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/b2g-inbound/0c5552dc5878?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-11-20 03:58:33,343 unpacking tar archive at: b2g-inbound-0c5552dc5878/testing/mozharness/ program finished with exit code 0 elapsedTime=1.470070 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-11-20 03:58:33.453130) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-20 03:58:33.453518) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-20 03:58:33.464688) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-20 03:58:33.465086) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-20 03:58:33.465529) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 55 secs) (at 2015-11-20 03:58:33.465886) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name B2G-Inbound --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch B2G-Inbound in dir /builds/slave/test-pgo/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'B2G-Inbound', '--system-bits', '64', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'B2G-Inbound'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test-pgo/buildprops.json PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=d6a7e047ef025f707024e163000001c3-1448020680.460833-619040387 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 03:58:33 INFO - MultiFileLogger online at 20151120 03:58:33 in /builds/slave/test-pgo 03:58:33 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name B2G-Inbound --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch B2G-Inbound 03:58:33 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 03:58:33 INFO - {'append_to_log': False, 03:58:33 INFO - 'base_work_dir': '/builds/slave/test-pgo', 03:58:33 INFO - 'blob_upload_branch': 'B2G-Inbound', 03:58:33 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 03:58:33 INFO - 'branch': 'B2G-Inbound', 03:58:33 INFO - 'buildbot_json_path': 'buildprops.json', 03:58:33 INFO - 'config_files': ('talos/linux_config.py',), 03:58:33 INFO - 'default_actions': ('clobber', 03:58:33 INFO - 'read-buildbot-config', 03:58:33 INFO - 'download-and-extract', 03:58:33 INFO - 'populate-webroot', 03:58:33 INFO - 'create-virtualenv', 03:58:33 INFO - 'install', 03:58:33 INFO - 'run-tests'), 03:58:33 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:58:33 INFO - 'download_minidump_stackwalk': True, 03:58:33 INFO - 'download_symbols': 'ondemand', 03:58:33 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:58:33 INFO - 'tooltool.py': '/tools/tooltool.py', 03:58:33 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:58:33 INFO - '/tools/misc-python/virtualenv.py')}, 03:58:33 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:58:33 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:58:33 INFO - 'installer_path': 'installer.exe', 03:58:33 INFO - 'log_level': 'info', 03:58:33 INFO - 'log_name': 'talos', 03:58:33 INFO - 'log_to_console': True, 03:58:33 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 03:58:33 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 03:58:33 INFO - 'opt_config_files': (), 03:58:33 INFO - 'pip_index': False, 03:58:33 INFO - 'sps_profile': False, 03:58:33 INFO - 'sps_profile_interval': 0, 03:58:33 INFO - 'suite': 'dromaeojs', 03:58:33 INFO - 'system_bits': '64', 03:58:33 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:58:33 INFO - 'title': 'talos-linux64-ix-016', 03:58:33 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:58:33 INFO - 'use_talos_json': True, 03:58:33 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 03:58:33 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:58:33 INFO - 'work_dir': 'build'} 03:58:33 INFO - ##### 03:58:33 INFO - ##### Running clobber step. 03:58:33 INFO - ##### 03:58:33 INFO - Running pre-action listener: _resource_record_pre_action 03:58:33 INFO - Running main action method: clobber 03:58:33 INFO - rmtree: /builds/slave/test-pgo/build 03:58:33 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 03:58:34 INFO - Running post-action listener: _resource_record_post_action 03:58:34 INFO - ##### 03:58:34 INFO - ##### Running read-buildbot-config step. 03:58:34 INFO - ##### 03:58:34 INFO - Running pre-action listener: _resource_record_pre_action 03:58:34 INFO - Running main action method: read_buildbot_config 03:58:34 INFO - Using buildbot properties: 03:58:34 INFO - { 03:58:34 INFO - "properties": { 03:58:34 INFO - "buildnumber": 984, 03:58:34 INFO - "product": "firefox", 03:58:34 INFO - "script_repo_revision": "production", 03:58:34 INFO - "builddir": "b2g-inbound_ubuntu64_hw_test-dromaeojs", 03:58:34 INFO - "repository": "", 03:58:34 INFO - "buildername": "Ubuntu HW 12.04 x64 b2g-inbound pgo talos dromaeojs", 03:58:34 INFO - "buildid": "20151120023024", 03:58:34 INFO - "slavename": "talos-linux64-ix-016", 03:58:34 INFO - "pgo_build": "True", 03:58:34 INFO - "basedir": "/builds/slave/test-pgo", 03:58:34 INFO - "project": "", 03:58:34 INFO - "platform": "ubuntu64_hw", 03:58:34 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 03:58:34 INFO - "slavebuilddir": "test", 03:58:34 INFO - "scheduler": "tests-b2g-inbound-linux64-pgo-talos", 03:58:34 INFO - "branch": "b2g-inbound", 03:58:34 INFO - "repo_path": "integration/b2g-inbound", 03:58:34 INFO - "stage_platform": "linux64-pgo", 03:58:34 INFO - "builduid": "1da4e365967c40678ee31dfe1fcfab57", 03:58:34 INFO - "revision": "0c5552dc5878391f8597e3d62d804cf532b0272d" 03:58:34 INFO - }, 03:58:34 INFO - "sourcestamp": { 03:58:34 INFO - "repository": "", 03:58:34 INFO - "hasPatch": false, 03:58:34 INFO - "project": "", 03:58:34 INFO - "branch": "b2g-inbound-linux64-pgo-talos", 03:58:34 INFO - "changes": [ 03:58:34 INFO - { 03:58:34 INFO - "category": null, 03:58:34 INFO - "files": [ 03:58:34 INFO - { 03:58:34 INFO - "url": null, 03:58:34 INFO - "name": "https://queue.taskcluster.net/v1/task/ATdGB3SPQFWzVMJWZk27Xw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2" 03:58:34 INFO - } 03:58:34 INFO - ], 03:58:34 INFO - "repository": "", 03:58:34 INFO - "rev": "0c5552dc5878391f8597e3d62d804cf532b0272d", 03:58:34 INFO - "who": "sendchange", 03:58:34 INFO - "when": 1448020641, 03:58:34 INFO - "number": 6688088, 03:58:34 INFO - "comments": "", 03:58:34 INFO - "project": "", 03:58:34 INFO - "at": "Fri 20 Nov 2015 03:57:21", 03:58:34 INFO - "branch": "b2g-inbound-linux64-pgo-talos", 03:58:34 INFO - "revlink": "", 03:58:34 INFO - "properties": [ 03:58:34 INFO - [ 03:58:34 INFO - "buildid", 03:58:34 INFO - "20151120023024", 03:58:34 INFO - "Change" 03:58:34 INFO - ], 03:58:34 INFO - [ 03:58:34 INFO - "builduid", 03:58:34 INFO - "1da4e365967c40678ee31dfe1fcfab57", 03:58:34 INFO - "Change" 03:58:34 INFO - ], 03:58:34 INFO - [ 03:58:34 INFO - "pgo_build", 03:58:34 INFO - "True", 03:58:34 INFO - "Change" 03:58:34 INFO - ] 03:58:34 INFO - ], 03:58:34 INFO - "revision": "0c5552dc5878391f8597e3d62d804cf532b0272d" 03:58:34 INFO - } 03:58:34 INFO - ], 03:58:34 INFO - "revision": "0c5552dc5878391f8597e3d62d804cf532b0272d" 03:58:34 INFO - } 03:58:34 INFO - } 03:58:34 INFO - Found installer url https://queue.taskcluster.net/v1/task/ATdGB3SPQFWzVMJWZk27Xw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2. 03:58:34 INFO - Running post-action listener: _resource_record_post_action 03:58:34 INFO - ##### 03:58:34 INFO - ##### Running download-and-extract step. 03:58:34 INFO - ##### 03:58:34 INFO - Running pre-action listener: _resource_record_pre_action 03:58:34 INFO - Running main action method: download_and_extract 03:58:34 INFO - mkdir: /builds/slave/test-pgo/build/tests 03:58:34 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')]} 03:58:34 INFO - https://queue.taskcluster.net/v1/task/ATdGB3SPQFWzVMJWZk27Xw/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 03:58:34 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ATdGB3SPQFWzVMJWZk27Xw/artifacts/public/build/test_packages.json 03:58:34 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ATdGB3SPQFWzVMJWZk27Xw/artifacts/public/build/test_packages.json 03:58:34 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ATdGB3SPQFWzVMJWZk27Xw/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 03:58:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ATdGB3SPQFWzVMJWZk27Xw/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 03:58:34 INFO - Downloaded 1302 bytes. 03:58:34 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 03:58:34 INFO - Using the following test package requirements: 03:58:34 INFO - {u'common': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 03:58:34 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 03:58:34 INFO - u'firefox-45.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 03:58:34 INFO - u'jittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 03:58:34 INFO - u'jsshell-linux-x86_64.zip'], 03:58:34 INFO - u'mochitest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 03:58:34 INFO - u'firefox-45.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 03:58:34 INFO - u'mozbase': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 03:58:34 INFO - u'reftest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 03:58:34 INFO - u'firefox-45.0a1.en-US.linux-x86_64.reftest.tests.zip'], 03:58:34 INFO - u'talos': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 03:58:34 INFO - u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'], 03:58:34 INFO - u'web-platform': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 03:58:34 INFO - u'firefox-45.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 03:58:34 INFO - u'webapprt': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 03:58:34 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 03:58:34 INFO - u'firefox-45.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 03:58:34 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 03:58:34 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')]} 03:58:34 INFO - https://queue.taskcluster.net/v1/task/ATdGB3SPQFWzVMJWZk27Xw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 03:58:34 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ATdGB3SPQFWzVMJWZk27Xw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 03:58:34 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ATdGB3SPQFWzVMJWZk27Xw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 03:58:34 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ATdGB3SPQFWzVMJWZk27Xw/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 03:58:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ATdGB3SPQFWzVMJWZk27Xw/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 03:58:36 INFO - Downloaded 22520522 bytes. 03:58:36 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 03:58:36 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 03:58:36 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 03:58:37 INFO - Return code: 0 03:58:37 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 03:58:37 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')]} 03:58:37 INFO - https://queue.taskcluster.net/v1/task/ATdGB3SPQFWzVMJWZk27Xw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 03:58:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ATdGB3SPQFWzVMJWZk27Xw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 03:58:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ATdGB3SPQFWzVMJWZk27Xw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 03:58:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ATdGB3SPQFWzVMJWZk27Xw/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 03:58:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ATdGB3SPQFWzVMJWZk27Xw/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 03:58:38 INFO - Downloaded 22520522 bytes. 03:58:38 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 03:58:38 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 03:58:38 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 03:58:40 INFO - Return code: 0 03:58:40 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')]} 03:58:40 INFO - https://queue.taskcluster.net/v1/task/ATdGB3SPQFWzVMJWZk27Xw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 03:58:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ATdGB3SPQFWzVMJWZk27Xw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 03:58:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ATdGB3SPQFWzVMJWZk27Xw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 03:58:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ATdGB3SPQFWzVMJWZk27Xw/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 03:58:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ATdGB3SPQFWzVMJWZk27Xw/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 03:58:41 INFO - Downloaded 11130997 bytes. 03:58:41 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 03:58:41 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 03:58:41 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 03:58:41 INFO - Return code: 0 03:58:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:58:41 INFO - https://queue.taskcluster.net/v1/task/ATdGB3SPQFWzVMJWZk27Xw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 03:58:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ATdGB3SPQFWzVMJWZk27Xw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 03:58:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ATdGB3SPQFWzVMJWZk27Xw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 03:58:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ATdGB3SPQFWzVMJWZk27Xw/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 03:58:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ATdGB3SPQFWzVMJWZk27Xw/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 03:58:43 INFO - Downloaded 57343514 bytes. 03:58:43 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/ATdGB3SPQFWzVMJWZk27Xw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 03:58:43 INFO - mkdir: /builds/slave/test-pgo/properties 03:58:43 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 03:58:43 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 03:58:43 INFO - Contents: 03:58:43 INFO - build_url:https://queue.taskcluster.net/v1/task/ATdGB3SPQFWzVMJWZk27Xw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 03:58:43 INFO - Running post-action listener: _resource_record_post_action 03:58:43 INFO - Running post-action listener: set_extra_try_arguments 03:58:43 INFO - ##### 03:58:43 INFO - ##### Running populate-webroot step. 03:58:43 INFO - ##### 03:58:43 INFO - Running pre-action listener: _resource_record_pre_action 03:58:43 INFO - Running main action method: populate_webroot 03:58:43 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 03:58:43 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 03:58:43 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 03:58:43 INFO - '../fennec_ids.txt'], 03:58:43 INFO - 'tests': ['tcheck2']}, 03:58:43 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 03:58:43 INFO - '--tppagecycles', 03:58:43 INFO - '7'], 03:58:43 INFO - 'tests': ['tsvgm']}}, 03:58:43 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 03:58:43 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 03:58:43 INFO - 'tests': ['tresize', 'tcanvasmark']}, 03:58:43 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 03:58:43 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 03:58:43 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 03:58:43 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:58:43 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:58:43 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:58:43 INFO - 'talos_options': ['--e10s'], 03:58:43 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:58:43 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:58:43 INFO - 'tests': ['damp', 'tps']}, 03:58:43 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:58:43 INFO - 'talos_options': ['--e10s'], 03:58:43 INFO - 'tests': ['damp', 'tps']}, 03:58:43 INFO - 'g3': {'tests': ['dromaeo_dom']}, 03:58:43 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:58:43 INFO - 'other': {'tests': ['a11yr', 03:58:43 INFO - 'ts_paint', 03:58:43 INFO - 'tpaint', 03:58:43 INFO - 'sessionrestore', 03:58:43 INFO - 'sessionrestore_no_auto_restore']}, 03:58:43 INFO - 'other-e10s': {'talos_options': ['--e10s'], 03:58:43 INFO - 'tests': ['a11yr', 03:58:43 INFO - 'ts_paint', 03:58:43 INFO - 'tpaint', 03:58:43 INFO - 'sessionrestore', 03:58:43 INFO - 'sessionrestore_no_auto_restore']}, 03:58:43 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 03:58:43 INFO - 'tests': ['a11yr', 03:58:43 INFO - 'ts_paint', 03:58:43 INFO - 'tpaint', 03:58:43 INFO - 'sessionrestore', 03:58:43 INFO - 'sessionrestore_no_auto_restore']}, 03:58:43 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 03:58:43 INFO - 'tests': ['a11yr', 03:58:43 INFO - 'ts_paint', 03:58:43 INFO - 'tpaint', 03:58:43 INFO - 'sessionrestore', 03:58:43 INFO - 'sessionrestore_no_auto_restore']}, 03:58:43 INFO - 'other_l64': {'tests': ['a11yr', 03:58:43 INFO - 'ts_paint', 03:58:43 INFO - 'tpaint', 03:58:43 INFO - 'sessionrestore', 03:58:43 INFO - 'sessionrestore_no_auto_restore']}, 03:58:43 INFO - 'other_nol64': {'tests': ['a11yr', 03:58:43 INFO - 'ts_paint', 03:58:43 INFO - 'tpaint', 03:58:43 INFO - 'sessionrestore', 03:58:43 INFO - 'sessionrestore_no_auto_restore']}, 03:58:43 INFO - 'svgr': {'tests': ['tsvgx', 03:58:43 INFO - 'tsvgr_opacity', 03:58:43 INFO - 'tart', 03:58:43 INFO - 'tscrollx', 03:58:43 INFO - 'cart']}, 03:58:43 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 03:58:43 INFO - 'tests': ['tsvgx', 03:58:43 INFO - 'tsvgr_opacity', 03:58:43 INFO - 'tart', 03:58:43 INFO - 'tscrollx', 03:58:43 INFO - 'cart']}, 03:58:43 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:58:43 INFO - 'tests': ['tp5o']}, 03:58:43 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:58:43 INFO - 'talos_options': ['--e10s'], 03:58:43 INFO - 'tests': ['tp5o']}, 03:58:43 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:58:43 INFO - 'talos_options': ['--xperf_path', 03:58:43 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:58:43 INFO - 'tests': ['tp5n']}, 03:58:43 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:58:43 INFO - 'talos_options': ['--e10s', 03:58:43 INFO - '--xperf_path', 03:58:43 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:58:43 INFO - 'tests': ['tp5n']}}, 03:58:43 INFO - 'talos.zip': {'path': '', 03:58:43 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 03:58:43 INFO - Running post-action listener: _resource_record_post_action 03:58:43 INFO - ##### 03:58:43 INFO - ##### Running create-virtualenv step. 03:58:43 INFO - ##### 03:58:43 INFO - Running pre-action listener: _resource_record_pre_action 03:58:43 INFO - Running main action method: create_virtualenv 03:58:43 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 03:58:43 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 03:58:43 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 03:58:43 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:58:43 INFO - Using real prefix '/usr' 03:58:43 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 03:58:44 INFO - Installing distribute.............................................................................................................................................................................................done. 03:58:46 INFO - Installing pip.................done. 03:58:46 INFO - Return code: 0 03:58:46 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 03:58:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:58:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:58:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:58:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:58:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:58:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:58:46 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 0x7ffd6a61bc70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21a26c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22636e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2299a90>, '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 0x22ebf70>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22ec2e0>, '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': 'd6a7e047ef025f707024e163000001c3-1448020680.460833-619040387', '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 03:58:46 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 03:58:46 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 03:58:46 INFO - Using env: {'DISPLAY': ':0', 03:58:46 INFO - 'HOME': '/home/cltbld', 03:58:46 INFO - 'LANG': 'en_US.UTF-8', 03:58:46 INFO - 'LANGUAGE': 'en_US:en', 03:58:46 INFO - 'LOGNAME': 'cltbld', 03:58:46 INFO - 'MAIL': '/var/mail/cltbld', 03:58:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:58:46 INFO - 'MOZ_NO_REMOTE': '1', 03:58:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:58:46 INFO - 'NO_EM_RESTART': '1', 03:58:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:58:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 03:58:46 INFO - 'PWD': '/builds/slave/test-pgo', 03:58:46 INFO - 'SHELL': '/bin/bash', 03:58:46 INFO - 'SHLVL': '1', 03:58:46 INFO - 'TERM': 'linux', 03:58:46 INFO - 'TMOUT': '86400', 03:58:46 INFO - 'USER': 'cltbld', 03:58:46 INFO - 'XDG_SESSION_COOKIE': 'd6a7e047ef025f707024e163000001c3-1448020680.460833-619040387', 03:58:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:58:46 INFO - '_': '/tools/buildbot/bin/python'} 03:58:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:58:46 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 03:58:46 INFO - Cleaning up... 03:58:46 INFO - Return code: 0 03:58:46 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 03:58:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:58:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:58:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:58:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:58:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:58:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:58:46 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 0x7ffd6a61bc70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21a26c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22636e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2299a90>, '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 0x22ebf70>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22ec2e0>, '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': 'd6a7e047ef025f707024e163000001c3-1448020680.460833-619040387', '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 03:58:46 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 03:58:46 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 03:58:46 INFO - Using env: {'DISPLAY': ':0', 03:58:46 INFO - 'HOME': '/home/cltbld', 03:58:46 INFO - 'LANG': 'en_US.UTF-8', 03:58:46 INFO - 'LANGUAGE': 'en_US:en', 03:58:46 INFO - 'LOGNAME': 'cltbld', 03:58:46 INFO - 'MAIL': '/var/mail/cltbld', 03:58:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:58:46 INFO - 'MOZ_NO_REMOTE': '1', 03:58:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:58:46 INFO - 'NO_EM_RESTART': '1', 03:58:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:58:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 03:58:46 INFO - 'PWD': '/builds/slave/test-pgo', 03:58:46 INFO - 'SHELL': '/bin/bash', 03:58:46 INFO - 'SHLVL': '1', 03:58:46 INFO - 'TERM': 'linux', 03:58:46 INFO - 'TMOUT': '86400', 03:58:46 INFO - 'USER': 'cltbld', 03:58:46 INFO - 'XDG_SESSION_COOKIE': 'd6a7e047ef025f707024e163000001c3-1448020680.460833-619040387', 03:58:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:58:46 INFO - '_': '/tools/buildbot/bin/python'} 03:58:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:58:46 INFO - Downloading/unpacking psutil>=0.7.1 03:58:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:58:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:58:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:58:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:58:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:58:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:58:48 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 03:58:48 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 03:58:48 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 03:58:48 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:58:48 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:58:48 INFO - Installing collected packages: psutil 03:58:48 INFO - Running setup.py install for psutil 03:58:48 INFO - building 'psutil._psutil_linux' extension 03:58:48 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 03:58:48 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 03:58:48 INFO - building 'psutil._psutil_posix' extension 03:58:48 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 03:58:49 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 03:58:49 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:58:49 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:58:49 INFO - Successfully installed psutil 03:58:49 INFO - Cleaning up... 03:58:49 INFO - Return code: 0 03:58:49 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 03:58:49 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')]} 03:58:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:58:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:58:49 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')]} 03:58:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:58:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:58:49 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 0x7ffd6a61bc70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21a26c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22636e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2299a90>, '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 0x22ebf70>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22ec2e0>, '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': 'd6a7e047ef025f707024e163000001c3-1448020680.460833-619040387', '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 03:58:49 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 03:58:49 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 03:58:49 INFO - Using env: {'DISPLAY': ':0', 03:58:49 INFO - 'HOME': '/home/cltbld', 03:58:49 INFO - 'LANG': 'en_US.UTF-8', 03:58:49 INFO - 'LANGUAGE': 'en_US:en', 03:58:49 INFO - 'LOGNAME': 'cltbld', 03:58:49 INFO - 'MAIL': '/var/mail/cltbld', 03:58:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:58:49 INFO - 'MOZ_NO_REMOTE': '1', 03:58:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:58:49 INFO - 'NO_EM_RESTART': '1', 03:58:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:58:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 03:58:49 INFO - 'PWD': '/builds/slave/test-pgo', 03:58:49 INFO - 'SHELL': '/bin/bash', 03:58:49 INFO - 'SHLVL': '1', 03:58:49 INFO - 'TERM': 'linux', 03:58:49 INFO - 'TMOUT': '86400', 03:58:49 INFO - 'USER': 'cltbld', 03:58:49 INFO - 'XDG_SESSION_COOKIE': 'd6a7e047ef025f707024e163000001c3-1448020680.460833-619040387', 03:58:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:58:49 INFO - '_': '/tools/buildbot/bin/python'} 03:58:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:58:49 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 03:58: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 03:58: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 03:58: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 03:58: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 03:58: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 03:58: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 03:58:51 INFO - Downloading mozsystemmonitor-0.0.tar.gz 03:58:51 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 03:58:51 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:58:51 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 03:58:51 INFO - Installing collected packages: mozsystemmonitor 03:58:51 INFO - Running setup.py install for mozsystemmonitor 03:58:51 INFO - Successfully installed mozsystemmonitor 03:58:51 INFO - Cleaning up... 03:58:51 INFO - Return code: 0 03:58:51 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 03:58:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:58:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:58:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:58:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:58:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:58:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:58:51 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7ffd6a61bc70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21a26c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22636e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2299a90>, '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 0x22ebf70>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22ec2e0>, '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': 'd6a7e047ef025f707024e163000001c3-1448020680.460833-619040387', '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 03:58:51 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test-pgo/build 03:58:51 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 03:58:51 INFO - Using env: {'DISPLAY': ':0', 03:58:51 INFO - 'HOME': '/home/cltbld', 03:58:51 INFO - 'LANG': 'en_US.UTF-8', 03:58:51 INFO - 'LANGUAGE': 'en_US:en', 03:58:51 INFO - 'LOGNAME': 'cltbld', 03:58:51 INFO - 'MAIL': '/var/mail/cltbld', 03:58:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:58:51 INFO - 'MOZ_NO_REMOTE': '1', 03:58:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:58:51 INFO - 'NO_EM_RESTART': '1', 03:58:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:58:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 03:58:51 INFO - 'PWD': '/builds/slave/test-pgo', 03:58:51 INFO - 'SHELL': '/bin/bash', 03:58:51 INFO - 'SHLVL': '1', 03:58:51 INFO - 'TERM': 'linux', 03:58:51 INFO - 'TMOUT': '86400', 03:58:51 INFO - 'USER': 'cltbld', 03:58:51 INFO - 'XDG_SESSION_COOKIE': 'd6a7e047ef025f707024e163000001c3-1448020680.460833-619040387', 03:58:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:58:51 INFO - '_': '/tools/buildbot/bin/python'} 03:58:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:58:51 INFO - Downloading/unpacking blobuploader==1.2.4 03:58:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:58:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:58:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:58:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:58:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:58:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:58:53 INFO - Downloading blobuploader-1.2.4.tar.gz 03:58:53 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 03:58:53 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:58:53 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:58:53 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 03:58:53 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 03:58:53 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 03:58:53 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 03:58:53 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 03:58:53 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 03:58:53 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 03:58:53 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 03:58:53 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:58:53 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 03:58:53 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 03:58:53 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 03:58:53 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 03:58:53 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 03:58:53 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 03:58:53 INFO - Downloading docopt-0.6.1.tar.gz 03:58:53 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 03:58:53 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 03:58:53 INFO - Installing collected packages: blobuploader, requests, docopt 03:58:53 INFO - Running setup.py install for blobuploader 03:58:54 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:58:54 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 03:58:54 INFO - Running setup.py install for requests 03:58:54 INFO - Running setup.py install for docopt 03:58:54 INFO - Successfully installed blobuploader requests docopt 03:58:54 INFO - Cleaning up... 03:58:54 INFO - Return code: 0 03:58:54 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 03:58: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')]} 03:58:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:58:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:58: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')]} 03:58:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:58:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:58:54 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 0x7ffd6a61bc70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21a26c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22636e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2299a90>, '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 0x22ebf70>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22ec2e0>, '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': 'd6a7e047ef025f707024e163000001c3-1448020680.460833-619040387', '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 03:58:54 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 03:58:54 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 03:58:54 INFO - Using env: {'DISPLAY': ':0', 03:58:54 INFO - 'HOME': '/home/cltbld', 03:58:54 INFO - 'LANG': 'en_US.UTF-8', 03:58:54 INFO - 'LANGUAGE': 'en_US:en', 03:58:54 INFO - 'LOGNAME': 'cltbld', 03:58:54 INFO - 'MAIL': '/var/mail/cltbld', 03:58:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:58:54 INFO - 'MOZ_NO_REMOTE': '1', 03:58:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:58:54 INFO - 'NO_EM_RESTART': '1', 03:58:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:58:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 03:58:54 INFO - 'PWD': '/builds/slave/test-pgo', 03:58:54 INFO - 'SHELL': '/bin/bash', 03:58:54 INFO - 'SHLVL': '1', 03:58:54 INFO - 'TERM': 'linux', 03:58:54 INFO - 'TMOUT': '86400', 03:58:54 INFO - 'USER': 'cltbld', 03:58:54 INFO - 'XDG_SESSION_COOKIE': 'd6a7e047ef025f707024e163000001c3-1448020680.460833-619040387', 03:58:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:58:54 INFO - '_': '/tools/buildbot/bin/python'} 03:58:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:58:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 03:58:54 INFO - Running setup.py (path:/tmp/pip-3bD2sb-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 03:58:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 03:58:54 INFO - Running setup.py (path:/tmp/pip-ExRq8N-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 03:58:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 03:58:54 INFO - Running setup.py (path:/tmp/pip-uHazxA-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 03:58:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 03:58:54 INFO - Running setup.py (path:/tmp/pip-C1tBO9-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 03:58:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 03:58:55 INFO - Running setup.py (path:/tmp/pip-HAQwPs-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 03:58:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 03:58:55 INFO - Running setup.py (path:/tmp/pip-vhFTYf-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 03:58:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 03:58:55 INFO - Running setup.py (path:/tmp/pip-tNUsYw-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 03:58:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 03:58:55 INFO - Running setup.py (path:/tmp/pip-9pMjYs-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 03:58:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 03:58:55 INFO - Running setup.py (path:/tmp/pip-THYBKs-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 03:58:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 03:58:55 INFO - Running setup.py (path:/tmp/pip-nxXApn-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 03:58:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 03:58:55 INFO - Running setup.py (path:/tmp/pip-Gr46cN-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 03:58:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 03:58:55 INFO - Running setup.py (path:/tmp/pip-gXy6_D-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 03:58:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 03:58:55 INFO - Running setup.py (path:/tmp/pip-ertPpA-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 03:58:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 03:58:55 INFO - Running setup.py (path:/tmp/pip-PLEmav-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 03:58:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 03:58:55 INFO - Running setup.py (path:/tmp/pip-Fxi1Vy-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 03:58:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 03:58:55 INFO - Running setup.py (path:/tmp/pip-MfQMAX-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 03:58:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 03:58:55 INFO - Running setup.py (path:/tmp/pip-6dO3KR-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 03:58:55 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:58:55 INFO - Running setup.py install for manifestparser 03:58:56 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 03:58:56 INFO - Running setup.py install for mozcrash 03:58:56 INFO - Running setup.py install for mozdebug 03:58:56 INFO - Running setup.py install for mozdevice 03:58:56 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 03:58:56 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 03:58:56 INFO - Running setup.py install for mozfile 03:58:56 INFO - Running setup.py install for mozhttpd 03:58:56 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 03:58:56 INFO - Running setup.py install for mozinfo 03:58:56 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 03:58:56 INFO - Running setup.py install for mozInstall 03:58:56 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 03:58:56 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 03:58:56 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 03:58:56 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 03:58:56 INFO - Running setup.py install for mozleak 03:58:56 INFO - Running setup.py install for mozlog 03:58:56 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 03:58:57 INFO - Running setup.py install for moznetwork 03:58:57 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 03:58:57 INFO - Running setup.py install for mozprocess 03:58:57 INFO - Running setup.py install for mozprofile 03:58:57 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 03:58:57 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 03:58:57 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 03:58:57 INFO - Running setup.py install for mozrunner 03:58:57 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 03:58:57 INFO - Running setup.py install for mozscreenshot 03:58:57 INFO - Running setup.py install for moztest 03:58:57 INFO - Running setup.py install for mozversion 03:58:57 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 03:58:57 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:58:57 INFO - Cleaning up... 03:58:57 INFO - Return code: 0 03:58:57 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 03:58: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')]} 03:58:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:58:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:58: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')]} 03:58:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:58:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:58: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/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 0x7ffd6a61bc70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21a26c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22636e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2299a90>, '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 0x22ebf70>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22ec2e0>, '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': 'd6a7e047ef025f707024e163000001c3-1448020680.460833-619040387', '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 03:58: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/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 03:58: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/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 03:58:57 INFO - Using env: {'DISPLAY': ':0', 03:58:57 INFO - 'HOME': '/home/cltbld', 03:58:57 INFO - 'LANG': 'en_US.UTF-8', 03:58:57 INFO - 'LANGUAGE': 'en_US:en', 03:58:57 INFO - 'LOGNAME': 'cltbld', 03:58:57 INFO - 'MAIL': '/var/mail/cltbld', 03:58:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:58:57 INFO - 'MOZ_NO_REMOTE': '1', 03:58:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:58:57 INFO - 'NO_EM_RESTART': '1', 03:58:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:58:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 03:58:57 INFO - 'PWD': '/builds/slave/test-pgo', 03:58:57 INFO - 'SHELL': '/bin/bash', 03:58:57 INFO - 'SHLVL': '1', 03:58:57 INFO - 'TERM': 'linux', 03:58:57 INFO - 'TMOUT': '86400', 03:58:57 INFO - 'USER': 'cltbld', 03:58:57 INFO - 'XDG_SESSION_COOKIE': 'd6a7e047ef025f707024e163000001c3-1448020680.460833-619040387', 03:58:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:58:57 INFO - '_': '/tools/buildbot/bin/python'} 03:58:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:58:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 03:58:57 INFO - Running setup.py (path:/tmp/pip-B7pkSC-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 03:58:58 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)) 03:58:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 03:58:58 INFO - Running setup.py (path:/tmp/pip-T_bLvo-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 03:58:58 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)) 03:58:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 03:58:58 INFO - Running setup.py (path:/tmp/pip-wxROHg-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 03:58:58 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)) 03:58:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 03:58:58 INFO - Running setup.py (path:/tmp/pip-yPchYH-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 03:58:58 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)) 03:58:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 03:58:58 INFO - Running setup.py (path:/tmp/pip-AHxbTC-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 03:58:58 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)) 03:58:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 03:58:58 INFO - Running setup.py (path:/tmp/pip-aXx_2V-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 03:58:58 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)) 03:58:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 03:58:58 INFO - Running setup.py (path:/tmp/pip-QcKS4R-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 03:58:58 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)) 03:58:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 03:58:58 INFO - Running setup.py (path:/tmp/pip-gW9J_f-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 03:58:58 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)) 03:58:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 03:58:58 INFO - Running setup.py (path:/tmp/pip-4y8dJN-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 03:58:58 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)) 03:58:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 03:58:58 INFO - Running setup.py (path:/tmp/pip-e5LYAv-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 03:58:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.0 from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 03:58:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 03:58:58 INFO - Running setup.py (path:/tmp/pip-pyGBwV-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 03:58:58 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)) 03:58:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 03:58:58 INFO - Running setup.py (path:/tmp/pip-J466HI-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 03:58:58 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)) 03:58:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 03:58:58 INFO - Running setup.py (path:/tmp/pip-znWWFt-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 03:58:58 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)) 03:58:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 03:58:58 INFO - Running setup.py (path:/tmp/pip-2JPxnV-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 03:58:58 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)) 03:58:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 03:58:58 INFO - Running setup.py (path:/tmp/pip-DevVa8-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 03:58:59 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)) 03:58:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 03:58:59 INFO - Running setup.py (path:/tmp/pip-OuX4cZ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 03:58:59 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)) 03:58:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 03:58:59 INFO - Running setup.py (path:/tmp/pip-8nmXwR-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 03:58:59 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)) 03:58:59 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)) 03:58:59 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)) 03:58:59 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)) 03:58:59 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)) 03:58:59 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)) 03:58:59 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.0->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 03:58: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 03:58: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 03:58: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 03:58: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 03:58: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 03:58: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 03:59:00 INFO - Downloading blessings-1.5.1.tar.gz 03:59:00 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 03:59:00 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 03:59:00 INFO - Installing collected packages: blessings 03:59:00 INFO - Running setup.py install for blessings 03:59:01 INFO - Successfully installed blessings 03:59:01 INFO - Cleaning up... 03:59:01 INFO - Return code: 0 03:59:01 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 03:59:01 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 03:59:01 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 03:59:01 INFO - Reading from file tmpfile_stdout 03:59:01 INFO - Current package versions: 03:59:01 INFO - argparse == 1.2.1 03:59:01 INFO - blessings == 1.5.1 03:59:01 INFO - blobuploader == 1.2.4 03:59:01 INFO - docopt == 0.6.1 03:59:01 INFO - manifestparser == 1.1 03:59:01 INFO - mozInstall == 1.12 03:59:01 INFO - mozcrash == 0.16 03:59:01 INFO - mozdebug == 0.1 03:59:01 INFO - mozdevice == 0.47 03:59:01 INFO - mozfile == 1.2 03:59:01 INFO - mozhttpd == 0.7 03:59:01 INFO - mozinfo == 0.9 03:59:01 INFO - mozleak == 0.1 03:59:01 INFO - mozlog == 3.0 03:59:01 INFO - moznetwork == 0.27 03:59:01 INFO - mozprocess == 0.22 03:59:01 INFO - mozprofile == 0.27 03:59:01 INFO - mozrunner == 6.11 03:59:01 INFO - mozscreenshot == 0.1 03:59:01 INFO - mozsystemmonitor == 0.0 03:59:01 INFO - moztest == 0.7 03:59:01 INFO - mozversion == 1.4 03:59:01 INFO - psutil == 3.1.1 03:59:01 INFO - requests == 1.2.3 03:59:01 INFO - wsgiref == 0.1.2 03:59:01 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 03:59:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:59:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:59:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:59:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:59:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:59:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:59:01 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 0x7ffd6a61bc70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21a26c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22636e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2299a90>, '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 0x22ebf70>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22ec2e0>, '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': 'd6a7e047ef025f707024e163000001c3-1448020680.460833-619040387', '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 03:59:01 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 03:59:01 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 03:59:01 INFO - Using env: {'DISPLAY': ':0', 03:59:01 INFO - 'HOME': '/home/cltbld', 03:59:01 INFO - 'LANG': 'en_US.UTF-8', 03:59:01 INFO - 'LANGUAGE': 'en_US:en', 03:59:01 INFO - 'LOGNAME': 'cltbld', 03:59:01 INFO - 'MAIL': '/var/mail/cltbld', 03:59:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:59:01 INFO - 'MOZ_NO_REMOTE': '1', 03:59:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:59:01 INFO - 'NO_EM_RESTART': '1', 03:59:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:59:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 03:59:01 INFO - 'PWD': '/builds/slave/test-pgo', 03:59:01 INFO - 'SHELL': '/bin/bash', 03:59:01 INFO - 'SHLVL': '1', 03:59:01 INFO - 'TERM': 'linux', 03:59:01 INFO - 'TMOUT': '86400', 03:59:01 INFO - 'USER': 'cltbld', 03:59:01 INFO - 'XDG_SESSION_COOKIE': 'd6a7e047ef025f707024e163000001c3-1448020680.460833-619040387', 03:59:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:59:01 INFO - '_': '/tools/buildbot/bin/python'} 03:59:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:59:01 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)) 03:59:01 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)) 03:59:01 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)) 03:59:01 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)) 03:59:01 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)) 03:59:01 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)) 03:59:01 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)) 03:59:01 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)) 03:59:01 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)) 03:59:01 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)) 03:59:01 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)) 03:59:01 INFO - Cleaning up... 03:59:01 INFO - Return code: 0 03:59:01 INFO - Running post-action listener: _resource_record_post_action 03:59:01 INFO - Running post-action listener: _start_resource_monitoring 03:59:01 INFO - Starting resource monitoring. 03:59:01 INFO - ##### 03:59:01 INFO - ##### Running install step. 03:59:01 INFO - ##### 03:59:01 INFO - Running pre-action listener: _resource_record_pre_action 03:59:01 INFO - Running main action method: install 03:59:01 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 03:59:01 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 03:59:01 INFO - Reading from file tmpfile_stdout 03:59:01 INFO - Detecting whether we're running mozinstall >=1.0... 03:59:01 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 03:59:01 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 03:59:01 INFO - Reading from file tmpfile_stdout 03:59:01 INFO - Output received: 03:59:01 INFO - Usage: mozinstall [options] installer 03:59:01 INFO - Options: 03:59:01 INFO - -h, --help show this help message and exit 03:59:01 INFO - -d DEST, --destination=DEST 03:59:01 INFO - Directory to install application into. [default: 03:59:01 INFO - "/builds/slave/test-pgo"] 03:59:01 INFO - --app=APP Application being installed. [default: firefox] 03:59:01 INFO - mkdir: /builds/slave/test-pgo/build/application 03:59:01 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'] 03:59:01 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 03:59:16 INFO - Reading from file tmpfile_stdout 03:59:16 INFO - Output received: 03:59:16 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 03:59:16 INFO - Running post-action listener: _resource_record_post_action 03:59:16 INFO - ##### 03:59:16 INFO - ##### Running run-tests step. 03:59:16 INFO - ##### 03:59:16 INFO - Running pre-action listener: _resource_record_pre_action 03:59:16 INFO - Running main action method: run_tests 03:59:16 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 03:59:16 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 03:59:16 INFO - Python 2.7.3 03:59:16 INFO - Return code: 0 03:59:16 INFO - grabbing minidump binary from tooltool 03:59:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:59:16 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 0x2299a90>, '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 0x22ebf70>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22ec2e0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 03:59:16 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 03:59:16 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 03:59:16 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:59:16 INFO - Return code: 0 03:59:16 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 03:59:16 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 03:59:16 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 03:59:16 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 03:59:16 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 03:59:16 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'B2G-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ATdGB3SPQFWzVMJWZk27Xw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-016', '--webServer', 'localhost'] in /builds/slave/test-pgo/build 03:59:16 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --debug --branchName B2G-Inbound --suite dromaeojs --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/ATdGB3SPQFWzVMJWZk27Xw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-016 --webServer localhost 03:59:16 INFO - Using env: {'DISPLAY': ':0', 03:59:16 INFO - 'HOME': '/home/cltbld', 03:59:16 INFO - 'LANG': 'en_US.UTF-8', 03:59:16 INFO - 'LANGUAGE': 'en_US:en', 03:59:16 INFO - 'LOGNAME': 'cltbld', 03:59:16 INFO - 'MAIL': '/var/mail/cltbld', 03:59:16 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 03:59:16 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 03:59:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:59:16 INFO - 'MOZ_NO_REMOTE': '1', 03:59:16 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 03:59:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:59:16 INFO - 'NO_EM_RESTART': '1', 03:59:16 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:59:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 03:59:16 INFO - 'PWD': '/builds/slave/test-pgo', 03:59:16 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 03:59:16 INFO - 'SHELL': '/bin/bash', 03:59:16 INFO - 'SHLVL': '1', 03:59:16 INFO - 'TERM': 'linux', 03:59:16 INFO - 'TMOUT': '86400', 03:59:16 INFO - 'USER': 'cltbld', 03:59:16 INFO - 'XDG_SESSION_COOKIE': 'd6a7e047ef025f707024e163000001c3-1448020680.460833-619040387', 03:59:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:59:16 INFO - '_': '/tools/buildbot/bin/python'} 03:59:16 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'B2G-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ATdGB3SPQFWzVMJWZk27Xw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-016', '--webServer', 'localhost'] with output_timeout 3600 03:59:16 INFO - mozversion INFO | application_buildid: 20151120023024 03:59:16 INFO - mozversion INFO | application_changeset: 0c5552dc5878391f8597e3d62d804cf532b0272d 03:59:16 INFO - mozversion INFO | application_display_name: Nightly 03:59:16 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:59:16 INFO - mozversion INFO | application_name: Firefox 03:59:16 INFO - mozversion INFO | application_remotingname: firefox 03:59:16 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/b2g-inbound 03:59:16 INFO - mozversion INFO | application_vendor: Mozilla 03:59:16 INFO - mozversion INFO | application_version: 45.0a1 03:59:16 INFO - mozversion INFO | platform_buildid: 20151120023024 03:59:16 INFO - mozversion INFO | platform_changeset: 0c5552dc5878391f8597e3d62d804cf532b0272d 03:59:16 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/b2g-inbound 03:59:16 INFO - mozversion INFO | platform_version: 45.0a1 03:59:16 INFO - 2015-11-20 03:59:16,575 DEBUG : using testdate: 1448020756 03:59:16 INFO - 2015-11-20 03:59:16,575 DEBUG : actual date: 1448020756 03:59:16 INFO - 2015-11-20 03:59:16,586 INFO : starting webserver on 'localhost:39252' 03:59:16 INFO - 2015-11-20 03:59:16,587 INFO : Starting test suite talos-linux64-ix-016 03:59:16 INFO - 2015-11-20 03:59:16,587 INFO : Starting test dromaeo_css 03:59:16 INFO - 2015-11-20 03:59:16,587 DEBUG : operating with platform_type : linux_ 03:59:16 INFO - 2015-11-20 03:59:16,588 INFO : Initialising browser for dromaeo_css test... 03:59:16 INFO - 2015-11-20 03:59:16,604 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp969s0G/profile http://localhost:39252/getInfo.html 03:59:20 INFO - 2015-11-20 03:59:20,284 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 03:59:20 INFO - 2015-11-20 03:59:20,284 DEBUG : BROWSER_OUTPUT: colorDepth:24 03:59:20 INFO - 2015-11-20 03:59:20,284 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 03:59:20 INFO - 2015-11-20 03:59:20,284 DEBUG : BROWSER_OUTPUT: __metrics 03:59:20 INFO - 2015-11-20 03:59:20,502 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 03:59:21 INFO - 2015-11-20 03:59:21,723 INFO : Browser initialized. 03:59:21 INFO - 2015-11-20 03:59:21,724 INFO : Running cycle 1/1 for dromaeo_css test... 03:59:21 INFO - 2015-11-20 03:59:21,724 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp969s0G/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 03:59:33 INFO - 2015-11-20 03:59:33,454 DEBUG : BROWSER_OUTPUT: RSS: Main: 141414400 03:59:33 INFO - 2015-11-20 03:59:33,454 DEBUG : BROWSER_OUTPUT: 04:00:25 INFO - 2015-11-20 04:00:25,184 DEBUG : BROWSER_OUTPUT: 1448020825183 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:02:33 INFO - 2015-11-20 04:02:33,924 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39252/tests/dromaeo/cssquery-dojo.html (next: http://localhost:39252/tests/dromaeo/cssquery-ext.html) 04:02:35 INFO - 2015-11-20 04:02:35,074 DEBUG : BROWSER_OUTPUT: RSS: Main: 246808576 04:02:35 INFO - 2015-11-20 04:02:35,074 DEBUG : BROWSER_OUTPUT: 04:05:37 INFO - 2015-11-20 04:05:37,486 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39252/tests/dromaeo/cssquery-ext.html (next: http://localhost:39252/tests/dromaeo/cssquery-jquery.html) 04:05:38 INFO - 2015-11-20 04:05:38,056 DEBUG : BROWSER_OUTPUT: RSS: Main: 221392896 04:05:38 INFO - 2015-11-20 04:05:38,056 DEBUG : BROWSER_OUTPUT: 04:08:39 INFO - 2015-11-20 04:08:39,987 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39252/tests/dromaeo/cssquery-jquery.html (next: http://localhost:39252/tests/dromaeo/cssquery-mootools.html) 04:08:40 INFO - 2015-11-20 04:08:40,548 DEBUG : BROWSER_OUTPUT: RSS: Main: 213475328 04:08:40 INFO - 2015-11-20 04:08:40,548 DEBUG : BROWSER_OUTPUT: 04:11:42 INFO - 2015-11-20 04:11:42,435 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39252/tests/dromaeo/cssquery-mootools.html (next: http://localhost:39252/tests/dromaeo/cssquery-prototype.html) 04:11:43 INFO - 2015-11-20 04:11:43,002 DEBUG : BROWSER_OUTPUT: RSS: Main: 201060352 04:11:43 INFO - 2015-11-20 04:11:43,002 DEBUG : BROWSER_OUTPUT: 04:14:45 INFO - 2015-11-20 04:14:45,386 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39252/tests/dromaeo/cssquery-prototype.html (next: http://localhost:39252/tests/dromaeo/cssquery-yui.html) 04:14:45 INFO - 2015-11-20 04:14:45,955 DEBUG : BROWSER_OUTPUT: RSS: Main: 202104832 04:14:45 INFO - 2015-11-20 04:14:45,955 DEBUG : BROWSER_OUTPUT: 04:17:48 INFO - 2015-11-20 04:17:48,787 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39252/tests/dromaeo/cssquery-yui.html (next: http://localhost:39252/tests/dromaeo/cssquery-dojo.html) 04:17:49 INFO - 2015-11-20 04:17:49,031 DEBUG : BROWSER_OUTPUT: RSS: Main: 247185408 04:17:49 INFO - 2015-11-20 04:17:49,031 DEBUG : BROWSER_OUTPUT: 04:17:49 INFO - 2015-11-20 04:17:49,032 DEBUG : BROWSER_OUTPUT: __start_tp_report 04:17:49 INFO - 2015-11-20 04:17:49,033 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 04:17:49 INFO - 2015-11-20 04:17:49,033 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 04:17:49 INFO - 2015-11-20 04:17:49,033 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 04:17:49 INFO - 2015-11-20 04:17:49,033 DEBUG : BROWSER_OUTPUT: |0;dojo.html;3147.8898238561646;3196.2169268529215;3237.7409807215427;3246.220906982325;3255.8209298488587;5347.171188465784;5393.352797664281;5466.917996230055;5477.1510415885505;5479.917801232985;5264.868378290545;5335.599830012745;5380.24676545284;5388.353397592295;5431.755570999305;4963.081829861479;4989.950100498985;4991.151504244287;5015.348004759376;5079.568236699885;5098.974505127488;5146.794128234867;5192.376914770233;5211.843644690665;5215.1655735082395;4902.142125128088;4911.58251548617;4991.450940396553;5045.217991211368;5064.670796398241;4931.556159945586;4933.038057578774;4957.5786058185095;4978.626603004789;5017;4889.804407823683;4901.240307752304;4907.11671899058;4913.238448040559;4951.133551628451;5193.350831146106;5255.264263003182;5303.098473259555;5344.5724342052545;5425;5845.941540584582;5874.618149820248;5890.293164820249;5903.144044113623;5982.910256346158;5905.970470147665;5910.468057874769;5926.318473375574;5932.169496270526;5937.139114828326;5414.83755487336;5429.972850135763;5503.834884953458;5504.4770746778995;5506.33923929123;5923.141144534018;5923.466887980103;5955.374685657944;5958.523318134538;6007.068904319837;5706.8871570044275;5735.627184233012;5738.569607279471;5739.053056245756;5813.186153938452;5732.05421105513;5791.797287095016;5832.416758324219;5851.765929362778;5855.560832937546;5857.619254748428;5936.7031648417405;5941.821745347646;5988.820335389945;5990.251218597676;5851.32709738377;5970.671613061323;5982.282126144803;5983.640981541034;5988.341282458926;4327.870163895088;4550.97724511382;4579.22153233951;4586.4496260448295;4604.88487787808;3968.642822145963;3979.045029192973;4030.234255491506;4044.939325910114;4081.285774989365;5513.283273174462;5570.3315602127195;5574.219609254707;5575.832725018256;5579.9163012554845;5927.73325200367;5938.732757025944;5965.910511342333;5970.671613061323;5972.492338151219;5373.973130134403;5382.569394448513;5478.91781623276;5480.6437581557075;5511.779528818883;5140.897182056338;5193.584513238932;5196.818111366084;5197.038547868657;5211.687298762086;6104.542159338156;6117.938820611737;6118.1434599156155;6123.540734444934;6124.265088189357;5747.971260143672;5860.472557469678;5862.032764593794;5901.350851406428;6053.122297266959;6152.930675394121;6197.132401463708;6198.907016394667;6211.503079753699;6211.689415529115;5849.912251316318;5902.852428689145;5903.439173278532;5917;5964.373740757158;5834.27071616048;5857.9121313179485;5904.261967254093;5917.37867523921;5976.073708575178;5788.9131663024245;5832.008558544972;5834.533237340917;5838.737256823369;5841.153032810304;5794.420557944172;5843.152742852348;5851.414858514115;5853.707314634336;5859.824205273849;5490.80782172622;5599.412061733459;5646.2942132233475;5690.630109042899;5760.683162426107;5685.658860468385;5701.686407247641;5715.8856822864145;5725.627834190765;5776.797812076557;5614.382417933943;5614.887702246014;5623.297087864017;5623.943760562342;5633.718314084197 04:17:49 INFO - 2015-11-20 04:17:49,034 DEBUG : BROWSER_OUTPUT: |1;ext.html;553.2424298789068;589.8112603966731;593.7803012885233;604.9727762250699;608.7473698415158;31021.689783102163;39070.804645976765;40094.59905400945;40108.1978360433;40151.799241003755;41291.38062929059;41829;41833.16333673332;41864.37203441951;41966.790166049206;7645.885311720329;7754.1470438251745;8854.778630534223;9047.502387368691;10290.382577045364;10522.842157367646;10623.521941512612;10679.679609611685;10681.572737090508;10692.518836652369;10536.78926421471;10573.101286390665;10599.576016959312;10626.521806518725;10631.468426578678;7780.727674531393;8018.238267364562;10696.518656660392;10937.179711521589;10948.616798412017;10463.84304235437;10513.789724205473;10545.31455455393;10564.630237941636;10568.841467377995;39666.80166599178;40132.59867401318;40161;40181.79909100436;40198.59801401978;3384.5769278840144;3424.07549961509;3552.3960926642276;3736.3648179809497;4074.2258970795456;29591.408171836658;29896.355700436467;29914.85042574795;30087.247818804488;30382.088537343916;3937.0944682722848;3946.605339466059;4042.2925987952285;4108.4453598764385;4149.730267532601;273306;274719;275029;275754;276056;54000.45999540033;54783.178252326245;61212.38787612156;68065.3193468069;68924.65537672279;63329.36670633327;63406.68296658487;63544.364556353845;63562.68218658877;63698.68150659217;14220.21788801626;14373.64065898361;14381.424743010371;14386.496472623618;14412.207328596818;11778;12040.879591204151;12041.879581204075;12045.156839021185;12110.333931633844;20231.4942126448;20625.278115266196;20700.171993120406;20718.477858764047;20726.378208653765;8001.239882211181;8005.759827205193;8092.554909479917;8189.754307370788;8196.180381961876;920.2408013388981;993.5032483758121;1039.5062345385882;1042.3329069395593;1146.7706458708292;28154.718452815618;28665.85667071693;28986.710132898825;29194.7080529192;32844.83577582097;1025.251566356549;1044.8850626431085;1046.570905928581;1064.9627263045757;1149.781541507111;16610.75083873743;17377;17490.21294041771;17491.12544372802;17518.824811751972;353111;358540;360017;360711;360921;55099.449005510236;55314.44685553093;55496.44503554913;55561.44438555644;55615.44384556184;1337.0774165825549;1349.1770020287618;1374.29223949666;1374.587623712882;1383.5503461375092;29005.56491652669;30022.699773002863;30612.846935765177;31040.68959310378;32839.292934839235;49258;49886.750566246934;49921;50086.749566251936;50116.749416252685;299380;300019;302612;302913;303892;27929.301767455978;28517.572236416887;31099;31743;32739;38710.612893870704;38842.61157388503;39674;39768.403473947335;39773;35106.29787404186;35784;35995.82002090078;36234.637653623126;36532.269354613294;35995.64004360027;36316.455253170694;36590.634093659784;36741.44887826631;36769.448458272615;35159.64840351666;35441.82279088588;35840.46239306465;35866;35882.64117358793;30523.2369190772;31746.52380214345;32929.835350823094;33066.504002440466;33174;24650.753492465563;25054.62418063694;25240.747592524574;25521.61717574275;26783 04:17:49 INFO - 2015-11-20 04:17:49,037 DEBUG : BROWSER_OUTPUT: |2;jquery.html;347.85216283079683;349.4722968317839;354.29848899179626;361.8697268983166;362.9201575653356;15246.618834529143;15303.540893773177;16436.424725134624;17211.913940430295;18207.817921820777;16054.277557509911;16592.08743519106;17230.82769172308;17777.91111044443;17781.11094445279;4342.392065110887;4910.680805747633;4913.877153071184;4916.926246106311;4918.704877707349;3759.266942946113;3884.5726970033274;4840.782164802592;4868.707877527342;5162.328897243353;5280.128778751501;5320.866978325535;5323.361196656407;5340.813071542497;5343.171808369709;4998.825041123561;5200;5203.453637368098;5266.789328426858;5298.682079075268;4907.631927605408;5000.874978125539;5013.172826483662;5014.473480284554;5028.698278103326;11729.70675733105;11877.643670689893;11945.462454189583;11952.163348565604;13732.45070197191;2114.6722258050027;2116.460302622837;2124.4264048706764;2137.9893100534396;2151.4621344663833;9040.68357607487;9359.344845860793;9562.90437095627;11474.942625286903;12575.742425757442;1748.6240458301527;1759.780027496563;1769.6018395860956;1816.8001519832808;1862.5995410986568;59682;62625.37374626286;63281.36718632801;63366;63581;9803.852942205873;9942.950285248528;10100.696979090639;10107.444090574942;10165.440900750382;13507.257100859548;13524.864751352558;13536.729265414637;13538;13538.932305338607;7240.2035776064595;7526.435517336222;7577.052868391451;7618.047744031996;7791.337736292478;6859.7256109756045;6948.965255173692;6954.895676564855;7048.189458212269;7400.9629951850975;4165.812538435777;4278.893027674333;4381.802818873159;4408.58118478744;4438.667099967515;1651.157909466157;1717.1414292853574;1766.5406994181606;1839.1264149529134;2981.1652737233608;873.4802792338548;888.4757992784288;905.968291109808;962.9759256018516;1058.3914249306679;16165.919170404073;16843.242054107595;17237.741433878502;17266;17467.737983930252;924.9260059195249;964.7057647417605;973.868527748759;981.5435822342645;1009.3086235928413;9688.612455501701;10177.440240786827;10215.13171380441;10388.896111038945;10432.478376081166;514345;519061;520536;524978;529681;76086.6195669018;79022.67818574615;79311;79548.20451795524;80166;1096.0519150934385;1096.4627332606965;1140.4468832616174;1144.9313041217554;1161.6573110932295;15651;15732.685346292781;15745.44890928812;15797.605059873595;16102;35898;36352.63647363493;36434;37462.62537374591;38150.809245954704;43124;45319.773401132785;47777.28334075061;48330.275045873634;48351;9011;9284.118008789153;9294.907050929403;9301.72094837156;9303.860442093239;10749.838752418564;10811.837822432513;13430.93284533571;17001.149942503074;17407.21667524939;11534.94232528832;11786.823197652213;12373.505059797868;12902.870971290167;14966.775498367751;13920.58238252854;14070;14089.788653170415;14550.4907328243;14622.195779232245;14592.635184120481;14598.051126676732;14670.926645366704;14706.852931470548;14935.626609334418;8975.37172397952;9225.354225204172;9237.861432078389;9987.500624968578;10041.347312424668;11572.421378931189;14423.49517766873;14643.56069317922;14999.2500374983;15020.248987550798 04:17:49 INFO - 2015-11-20 04:17:49,038 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1360.2926478231327;1714.9657006859863;1746.231658070449;1766.108115401722;1777.6580029544455;7090.078289822322;7361.9631901840485;7408.814779630512;7415.592142432164;7429.182789893108;7602.77191684249;7753.883691744614;7766;7772.650230739616;7788.221177882209;2064.2465500092435;2094.120469402847;2096.4968407582223;2303.401115709919;2322.6864373309554;2313.8611683299055;2358.740538540759;2359.09174967637;2360.4334959609655;2363.196513185517;2197.3957161780477;2210.745764237109;2274.2040285899884;2274.317704688595;2277.487565297811;2016.4555569996091;2066.6693329067275;2069.834413246944;2254.030766770288;2294.713160854893;2177.575372802304;2179.56408718257;2182.1053368119155;2182.1162429216033;2182.1162429216192;7624.656890439944;7757.573333466714;7762.184970578121;7770.6114694265625;7776.572288524129;4690.906181876378;4758.3576217210575;4764.166270902579;4773.952260477386;4774.427068751737;3086.182161727144;3092.8144311341393;3166.889158879428;3174.8095114292987;3200.0399880035898;1017.5471914997829;1023.3399457350042;1037.901399367059;1046.1839764983324;1064.0370464729356;10592.099671527929;10601.363918164934;10613.150947924147;10650.4142272175;10702.946485267525;4250.149970005949;4328.09110086879;4361.367601697736;4366.061296821135;4379.802908869108;9119.316051296046;9121.179093881583;9165.862512062324;9176.541172941459;9187.173154416001;4744.976275118603;4745.3593764842;4775.617950563947;4779.808807647655;4782.784774685148;4287.892802679896;4320.287152619782;4328.458942632171;4328.761918094535;4336.804843782037;3723.646253605903;3777.0934975605655;3810.657040866335;3839.6352346527037;3840.0399900024995;1211.7213041000443;1219.152688881219;1221.4137214137086;1230.194222784078;1231.7474917641862;1047.858539097212;1063.0857462582173;1063.2238465919922;1212.7150119721857;1356.4777560639225;7185.89221161683;7235.335872749192;7252.709891604277;7252.854942901113;7594.962025189839;1055.055725126008;1080.9297395669257;1094.655183617158;1149.3448734221581;1157.427073598574;5605.607607467519;5738.483536481654;6053.848653783691;6197.907031394533;6199.783007594712;9182.540872956326;9222.538873056454;9529.809403811885;9576.952115239379;9588.041195880496;9475.810483790285;9478.431294122236;9525.761855953657;9535;9565.426074435556;7107.573545587281;7240.782776516713;7246.891296630555;7274.090738657668;7442.627868606548;7444.962775186089;7595.658195381332;7614.352780013539;7614.733484328022;7627.733029343946;8332.458390204618;8457.873131902903;8729.3889427742;8765.386422950587;8787.692430764893;8674.956625216833;8690;8711.172438618321;8803;8865.069167737294;7058.364747172779;7160.820979475555;7166.641667916688;7184.820379490555;7191.928080719126;7545.886811697719;7574.3183113520045;7592.16486186508;7592.924070759222;7597.164311925573;6733.0573719678305;7031;7125;7239.914012898107;7307.415406767552;6732.293109223657;6823.89764153548;6846.7945961621235;6880.58716477013;6915.273896240822;6863.553868998499;6985.720571177096;6986.755463558751;6998.40513556333;7039.718411263492;6561.704723287368;6597.406233439014;6615.735370585123;6627.105340778933;6636.170478690164;6051.4553690168095;6156.507479401547;6159.4456498915315;6474.741010359721;6530.8367290818105 04:17:49 INFO - 2015-11-20 04:17:49,039 DEBUG : BROWSER_OUTPUT: |4;prototype.html;325.51660783736156;329.5764942049465;329.981850998195;331.3588206819803;335.855582099697;6104.1759362486055;6138.846528836776;6159;6170.444659980601;6191.226096737908;5863.76544938202;5947.107933809931;6010.8797824043495;6070.332263451028;6099.024156135019;4650.651201159918;4658.114958157939;4668.393108895839;4680.25115981443;4702.153612349775;4468.218061839181;4697.88255293617;4707.482176960531;4711.92932106017;4714.5521175488275;4517.4804897436725;4521.457425108992;4662.650301227422;4669.112868554981;4681.39141911551;4627.259638457831;4634.768261586907;4653.464851542049;4655.976720116395;4662.836800711959;4082.2243773682903;4084.938725919084;4085.55058943516;4086.6322031017353;4088.264112459786;5724.141378793172;5804.941950580483;5819.73811178498;5822.126680997884;5822.505087067604;5385.461453854622;5386.622936394454;5402.810901618424;5403.51368376844;5403.540699040586;6464.903026454607;6489.091527186198;6499.447546958514;6500.837479063014;6503.6097834130105;4419.911601767946;4429.601335879786;4429.822807087713;4430.556944305576;4430.579094985971;6567.507436942248;6643.966780166068;6689.732410703566;6699.531032827704;6702.262751097375;4514.706544074625;4523.773811309421;4524.04994951064;4525.502194758574;4527.1398434298035;4572.222722137245;4572.382728331632;4572.9314060289125;4587.311903214544;4588.151192029485;5351.224072509543;5357.366003368932;5363.302770639792;5363.892722145535;5370.489803468664;6381.8085457436355;6524.314946930599;6526.771562995273;6527.738890444424;6530.575512591761;1599.5441299229665;1619.6598714270135;1622.4970259219679;1623.5048310265483;1624.3177865296605;1062.930909490896;1070.1064611049705;1072.1583556907947;1087.472575800736;1091.476091476096;6237.4698150657705;6239.344868788802;6241.999999999909;6244;6245.687715614292;6514.348565143542;6698.497612679069;6716.496262780311;6717.865642687118;6728.764493242713;6138.508919286446;6162.907556386658;6285.622862628165;6292.307846136921;6300.464460520907;3612.187257866959;3647.8905632831056;3652.1782598915033;3654.287413954253;3668.926621467556;6812.318768123148;6986.37122658953;6986.930130698628;6993;6993.2657071007825;6947.166340039126;6951.860962780716;6954.061201737802;6955.582665040114;6958;6972.058772065706;6983.580985140908;6990.405815505739;6997.405220556309;7000.194977577542;6610.735570577123;6741.258461569126;6741.2921643226755;6747.190337159573;6753.3921947025;6613.503987200883;6644.83387915306;6686.7993960181275;6697.162854643169;6701.195856497252;6979.54632948877;6997.580145191305;7008.789736307919;7018.75434359795;7020.929790702027;4393.406890069799;4470.351798989193;4492.73043617384;4499.77501124949;4502.302143167683;6733.158355205599;6733.797986060426;6739.460843132636;6746;6747.898781518379;6532.706028228646;6534.379233972765;6543.5419520633095;6546.509011824037;6547.869042619216;6395.7121929514215;6497.4477169441125;6540.215174179129;6546.116274302908;6552.967235163794;6410.8076757697345;6415.711292991733;6422.165118534747;6424.807255782334;6427.292997770335;6531.510136739668;6566.343365663586;6584.934150658432;6586.967065164835;6601.207855057231;6330.465677957578;6406.903896441464;6422.068800023877;6429.453496452854;6435.066915297162 04:17:49 INFO - 2015-11-20 04:17:49,039 DEBUG : BROWSER_OUTPUT: |5;yui.html;759.6923246085333;841.8063845315577;854.4232642965999;857.6097875466663;870.1211776106131;12867.356632168388;13192.340382980849;13209.735805283888;13215.669608259786;13221.735565288689;12972.675683107927;13055.60833175004;13067.21596704196;13075.084744067919;13090.280034598094;676.7868121541699;680.7549282258383;817.648411183191;818.4107442641289;830.8338332333527;832.142892820396;832.1595188859235;838.8741688746676;840.1220724343076;840.6553313141613;863.3740538109882;867.5705525764755;873.4933738431727;875.0986483921571;876.7457437343163;715.2454160860291;716.7849645106473;852.2542775071781;865.277493293101;866.2636758755008;633.7338317906444;635.1108448172549;638.1162090504685;638.2883085359837;639.6673729660597;13171.078024538287;13308.134971226838;13324.200547967055;13355.399007044609;13371.064025518217;12018.879811201863;12154.027677785843;12366.319852408114;12420.130590858644;12488.562900298446;10231.641892533726;10259.692209233735;10284.331518451352;10490.527926243338;10646.627368042158;3679.5400574928135;3688.188598508324;3714.0900479382453;3755.5493340799007;3870.322693528621;49273.260901086156;49876.25185622219;49918.00163996736;49965.750171249274;50268.74865625685;9976.351537150062;10025.949870250748;10128.898711012796;10457.84313235302;10519.21105917044;17891.105444727713;17917.910410447865;17944;17966.281348745903;17968.371107011455;7417.703291868373;7457.366123879422;7568.394528437711;7571.3942884569105;7667.731629392944;4265.658747300271;4286.5284818669925;4362.389265502832;4372.934405983913;4421.314696222091;3060.296131889678;3064.6169228846393;3088.4286407014774;3089.876404943822;3091.6599174090834;540.5459414092103;556.4018679919103;566.4731799426573;566.6854895533019;573.6988081257373;590.7253127295828;597.5279529171905;628.7547856336032;679.3308591037824;703.033329172388;8380.539070351067;8419.705310314232;8466.915330846736;8585.484870907641;8613.353998450142;488.50172823719606;525.542777783331;588.5085953229102;628.0704557255287;653.1867824558456;3680.247344536945;3911.6675082618294;4053.8783836484363;4087.570805065485;4190.057237121623;55566.44433555612;55580.16629750557;56109;56564.71717641468;59770.701146493986;49581.752091239316;50128;50142;50160.498395016315;50306.245406318936;45188.15900648482;45679.77160114178;45867;45960.54039459563;46104;7995.640196191302;8069.87895181561;8207.95896020516;8264.198788023894;8292.212239837207;33713.494297585064;34930.825345873105;34973.47539786854;35137.47293790647;35956;43861.342079869464;43938.34092488551;44361.33457998068;44481.55518444903;44957.325640116076;11082.944585277022;11090.500927458123;11399.886001139883;11507.827382589101;11524.59663911759;11622.593209237637;12064.879351206375;12403.75192496163;12455.190412623151;12465.376731163224;11358;11528.07775377951;11743.471543780379;11746.823797642872;12104.878951210727;11357.432128393382;11582.884171158517;11656.592019279284;11938.343391113573;11995.700107497383;11136.832947505633;11153.888461115284;11213.327200368005;11246.943765281121;11636.94181529087;8976.237019853386;9000.144986226298;9237.445753254826;9553.570089346134;9632.95183524078;8159.46963447374;8917.063708310534;8917.821643567222;9131.405337532213;9135.908640913505 04:17:49 INFO - 2015-11-20 04:17:49,039 DEBUG : BROWSER_OUTPUT: __end_tp_report 04:17:49 INFO - 2015-11-20 04:17:49,039 DEBUG : BROWSER_OUTPUT: __start_cc_report 04:17:49 INFO - 2015-11-20 04:17:49,040 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,836 04:17:49 INFO - 2015-11-20 04:17:49,040 DEBUG : BROWSER_OUTPUT: __end_cc_report 04:17:49 INFO - 2015-11-20 04:17:49,040 DEBUG : BROWSER_OUTPUT: __startTimestamp1448021869031__endTimestamp 04:17:49 INFO - 2015-11-20 04:17:49,040 DEBUG : BROWSER_OUTPUT: 04:17:49 INFO - 2015-11-20 04:17:49,041 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 04:17:49 INFO - 2015-11-20 04:17:49,041 DEBUG : BROWSER_OUTPUT: Number of tests: 6 04:17:49 INFO - 2015-11-20 04:17:49,041 DEBUG : BROWSER_OUTPUT: 04:17:49 INFO - 2015-11-20 04:17:49,041 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:5467.03 Median:5646.29 stddev:623.61 (11.0%) stddev-sans-first:598.40 04:17:49 INFO - 2015-11-20 04:17:49,041 DEBUG : BROWSER_OUTPUT: Values: 3147.9 3196.2 3237.7 3246.2 3255.8 5347.2 5393.4 5466.9 5477.2 5479.9 5264.9 5335.6 5380.2 5388.4 5431.8 4963.1 4990.0 4991.2 5015.3 5079.6 5099.0 5146.8 5192.4 5211.8 5215.2 4902.1 4911.6 4991.5 5045.2 5064.7 4931.6 4933.0 4957.6 4978.6 5017.0 4889.8 4901.2 4907.1 4913.2 4951.1 5193.4 5255.3 5303.1 5344.6 5425.0 5845.9 5874.6 5890.3 5903.1 5982.9 5906.0 5910.5 5926.3 5932.2 5937.1 5414.8 5430.0 5503.8 5504.5 5506.3 5923.1 5923.5 5955.4 5958.5 6007.1 5706.9 5735.6 5738.6 5739.1 5813.2 5732.1 5791.8 5832.4 5851.8 5855.6 5857.6 5936.7 5941.8 5988.8 5990.3 5851.3 5970.7 5982.3 5983.6 5988.3 4327.9 4551.0 4579.2 4586.4 4604.9 3968.6 3979.0 4030.2 4044.9 4081.3 5513.3 5570.3 5574.2 5575.8 5579.9 5927.7 5938.7 5965.9 5970.7 5972.5 5374.0 5382.6 5478.9 5480.6 5511.8 5140.9 5193.6 5196.8 5197.0 5211.7 6104.5 6117.9 6118.1 6123.5 6124.3 5748.0 5860.5 5862.0 5901.4 6053.1 6152.9 6197.1 6198.9 6211.5 6211.7 5849.9 5902.9 5903.4 5917.0 5964.4 5834.3 5857.9 5904.3 5917.4 5976.1 5788.9 5832.0 5834.5 5838.7 5841.2 5794.4 5843.2 5851.4 5853.7 5859.8 5490.8 5599.4 5646.3 5690.6 5760.7 5685.7 5701.7 5715.9 5725.6 5776.8 5614.4 5614.9 5623.3 5623.9 5633.7 04:17:49 INFO - 2015-11-20 04:17:49,041 DEBUG : BROWSER_OUTPUT: 04:17:49 INFO - 2015-11-20 04:17:49,041 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:48486.58 Median:32998.17 stddev:82109.44 (248.8%) stddev-sans-first:82260.91 04:17:49 INFO - 2015-11-20 04:17:49,041 DEBUG : BROWSER_OUTPUT: Values: 553.2 589.8 593.8 605.0 608.7 31021.7 39070.8 40094.6 40108.2 40151.8 41291.4 41829.0 41833.2 41864.4 41966.8 7645.9 7754.1 8854.8 9047.5 10290.4 10522.8 10623.5 10679.7 10681.6 10692.5 10536.8 10573.1 10599.6 10626.5 10631.5 7780.7 8018.2 10696.5 10937.2 10948.6 10463.8 10513.8 10545.3 10564.6 10568.8 39666.8 40132.6 40161.0 40181.8 40198.6 3384.6 3424.1 3552.4 3736.4 4074.2 29591.4 29896.4 29914.9 30087.2 30382.1 3937.1 3946.6 4042.3 4108.4 4149.7 273306.0 274719.0 275029.0 275754.0 276056.0 54000.5 54783.2 61212.4 68065.3 68924.7 63329.4 63406.7 63544.4 63562.7 63698.7 14220.2 14373.6 14381.4 14386.5 14412.2 11778.0 12040.9 12041.9 12045.2 12110.3 20231.5 20625.3 20700.2 20718.5 20726.4 8001.2 8005.8 8092.6 8189.8 8196.2 920.2 993.5 1039.5 1042.3 1146.8 28154.7 28665.9 28986.7 29194.7 32844.8 1025.3 1044.9 1046.6 1065.0 1149.8 16610.8 17377.0 17490.2 17491.1 17518.8 353111.0 358540.0 360017.0 360711.0 360921.0 55099.4 55314.4 55496.4 55561.4 55615.4 1337.1 1349.2 1374.3 1374.6 1383.6 29005.6 30022.7 30612.8 31040.7 32839.3 49258.0 49886.8 49921.0 50086.7 50116.7 299380.0 300019.0 302612.0 302913.0 303892.0 27929.3 28517.6 31099.0 31743.0 32739.0 38710.6 38842.6 39674.0 39768.4 39773.0 35106.3 35784.0 35995.8 36234.6 36532.3 35995.6 36316.5 36590.6 36741.4 36769.4 35159.6 35441.8 35840.5 35866.0 35882.6 30523.2 31746.5 32929.8 33066.5 33174.0 24650.8 25054.6 25240.7 25521.6 26783.0 04:17:49 INFO - 2015-11-20 04:17:49,041 DEBUG : BROWSER_OUTPUT: 04:17:49 INFO - 2015-11-20 04:17:49,041 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:28075.02 Median:18129.93 stddev:85331.98 (470.7%) stddev-sans-first:85545.96 04:17:49 INFO - 2015-11-20 04:17:49,041 DEBUG : BROWSER_OUTPUT: Values: 347.9 349.5 354.3 361.9 362.9 15246.6 15303.5 16436.4 17211.9 18207.8 16054.3 16592.1 17230.8 17777.9 17781.1 4342.4 4910.7 4913.9 4916.9 4918.7 3759.3 3884.6 4840.8 4868.7 5162.3 5280.1 5320.9 5323.4 5340.8 5343.2 4998.8 5200.0 5203.5 5266.8 5298.7 4907.6 5000.9 5013.2 5014.5 5028.7 11729.7 11877.6 11945.5 11952.2 13732.5 2114.7 2116.5 2124.4 2138.0 2151.5 9040.7 9359.3 9562.9 11474.9 12575.7 1748.6 1759.8 1769.6 1816.8 1862.6 59682.0 62625.4 63281.4 63366.0 63581.0 9803.9 9943.0 10100.7 10107.4 10165.4 13507.3 13524.9 13536.7 13538.0 13538.9 7240.2 7526.4 7577.1 7618.0 7791.3 6859.7 6949.0 6954.9 7048.2 7401.0 4165.8 4278.9 4381.8 4408.6 4438.7 1651.2 1717.1 1766.5 1839.1 2981.2 873.5 888.5 906.0 963.0 1058.4 16165.9 16843.2 17237.7 17266.0 17467.7 924.9 964.7 973.9 981.5 1009.3 9688.6 10177.4 10215.1 10388.9 10432.5 514345.0 519061.0 520536.0 524978.0 529681.0 76086.6 79022.7 79311.0 79548.2 80166.0 1096.1 1096.5 1140.4 1144.9 1161.7 15651.0 15732.7 15745.4 15797.6 16102.0 35898.0 36352.6 36434.0 37462.6 38150.8 43124.0 45319.8 47777.3 48330.3 48351.0 9011.0 9284.1 9294.9 9301.7 9303.9 10749.8 10811.8 13430.9 17001.1 17407.2 11534.9 11786.8 12373.5 12902.9 14966.8 13920.6 14070.0 14089.8 14550.5 14622.2 14592.6 14598.1 14670.9 14706.9 14935.6 8975.4 9225.4 9237.9 9987.5 10041.3 11572.4 14423.5 14643.6 14999.3 15020.2 04:17:49 INFO - 2015-11-20 04:17:49,042 DEBUG : BROWSER_OUTPUT: 04:17:49 INFO - 2015-11-20 04:17:49,042 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5497.97 Median:6178.68 stddev:2839.73 (46.0%) stddev-sans-first:2830.66 04:17:49 INFO - 2015-11-20 04:17:49,043 DEBUG : BROWSER_OUTPUT: Values: 1360.3 1715.0 1746.2 1766.1 1777.7 7090.1 7362.0 7408.8 7415.6 7429.2 7602.8 7753.9 7766.0 7772.7 7788.2 2064.2 2094.1 2096.5 2303.4 2322.7 2313.9 2358.7 2359.1 2360.4 2363.2 2197.4 2210.7 2274.2 2274.3 2277.5 2016.5 2066.7 2069.8 2254.0 2294.7 2177.6 2179.6 2182.1 2182.1 2182.1 7624.7 7757.6 7762.2 7770.6 7776.6 4690.9 4758.4 4764.2 4774.0 4774.4 3086.2 3092.8 3166.9 3174.8 3200.0 1017.5 1023.3 1037.9 1046.2 1064.0 10592.1 10601.4 10613.2 10650.4 10702.9 4250.1 4328.1 4361.4 4366.1 4379.8 9119.3 9121.2 9165.9 9176.5 9187.2 4745.0 4745.4 4775.6 4779.8 4782.8 4287.9 4320.3 4328.5 4328.8 4336.8 3723.6 3777.1 3810.7 3839.6 3840.0 1211.7 1219.2 1221.4 1230.2 1231.7 1047.9 1063.1 1063.2 1212.7 1356.5 7185.9 7235.3 7252.7 7252.9 7595.0 1055.1 1080.9 1094.7 1149.3 1157.4 5605.6 5738.5 6053.8 6197.9 6199.8 9182.5 9222.5 9529.8 9577.0 9588.0 9475.8 9478.4 9525.8 9535.0 9565.4 7107.6 7240.8 7246.9 7274.1 7442.6 7445.0 7595.7 7614.4 7614.7 7627.7 8332.5 8457.9 8729.4 8765.4 8787.7 8675.0 8690.0 8711.2 8803.0 8865.1 7058.4 7160.8 7166.6 7184.8 7191.9 7545.9 7574.3 7592.2 7592.9 7597.2 6733.1 7031.0 7125.0 7239.9 7307.4 6732.3 6823.9 6846.8 6880.6 6915.3 6863.6 6985.7 6986.8 6998.4 7039.7 6561.7 6597.4 6615.7 6627.1 6636.2 6051.5 6156.5 6159.4 6474.7 6530.8 04:17:49 INFO - 2015-11-20 04:17:49,043 DEBUG : BROWSER_OUTPUT: 04:17:49 INFO - 2015-11-20 04:17:49,043 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:5425.97 Median:6180.84 stddev:1656.07 (26.8%) stddev-sans-first:1615.86 04:17:49 INFO - 2015-11-20 04:17:49,043 DEBUG : BROWSER_OUTPUT: Values: 325.5 329.6 330.0 331.4 335.9 6104.2 6138.8 6159.0 6170.4 6191.2 5863.8 5947.1 6010.9 6070.3 6099.0 4650.7 4658.1 4668.4 4680.3 4702.2 4468.2 4697.9 4707.5 4711.9 4714.6 4517.5 4521.5 4662.7 4669.1 4681.4 4627.3 4634.8 4653.5 4656.0 4662.8 4082.2 4084.9 4085.6 4086.6 4088.3 5724.1 5804.9 5819.7 5822.1 5822.5 5385.5 5386.6 5402.8 5403.5 5403.5 6464.9 6489.1 6499.4 6500.8 6503.6 4419.9 4429.6 4429.8 4430.6 4430.6 6567.5 6644.0 6689.7 6699.5 6702.3 4514.7 4523.8 4524.0 4525.5 4527.1 4572.2 4572.4 4572.9 4587.3 4588.2 5351.2 5357.4 5363.3 5363.9 5370.5 6381.8 6524.3 6526.8 6527.7 6530.6 1599.5 1619.7 1622.5 1623.5 1624.3 1062.9 1070.1 1072.2 1087.5 1091.5 6237.5 6239.3 6242.0 6244.0 6245.7 6514.3 6698.5 6716.5 6717.9 6728.8 6138.5 6162.9 6285.6 6292.3 6300.5 3612.2 3647.9 3652.2 3654.3 3668.9 6812.3 6986.4 6986.9 6993.0 6993.3 6947.2 6951.9 6954.1 6955.6 6958.0 6972.1 6983.6 6990.4 6997.4 7000.2 6610.7 6741.3 6741.3 6747.2 6753.4 6613.5 6644.8 6686.8 6697.2 6701.2 6979.5 6997.6 7008.8 7018.8 7020.9 4393.4 4470.4 4492.7 4499.8 4502.3 6733.2 6733.8 6739.5 6746.0 6747.9 6532.7 6534.4 6543.5 6546.5 6547.9 6395.7 6497.4 6540.2 6546.1 6553.0 6410.8 6415.7 6422.2 6424.8 6427.3 6531.5 6566.3 6584.9 6587.0 6601.2 6330.5 6406.9 6422.1 6429.5 6435.1 04:17:49 INFO - 2015-11-20 04:17:49,043 DEBUG : BROWSER_OUTPUT: 04:17:49 INFO - 2015-11-20 04:17:49,043 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:13727.81 Median:45773.39 stddev:15868.55 (34.7%) stddev-sans-first:15883.18 04:17:49 INFO - 2015-11-20 04:17:49,043 DEBUG : BROWSER_OUTPUT: Values: 759.7 841.8 854.4 857.6 870.1 12867.4 13192.3 13209.7 13215.7 13221.7 12972.7 13055.6 13067.2 13075.1 13090.3 676.8 680.8 817.6 818.4 830.8 832.1 832.2 838.9 840.1 840.7 863.4 867.6 873.5 875.1 876.7 715.2 716.8 852.3 865.3 866.3 633.7 635.1 638.1 638.3 639.7 13171.1 13308.1 13324.2 13355.4 13371.1 12018.9 12154.0 12366.3 12420.1 12488.6 10231.6 10259.7 10284.3 10490.5 10646.6 3679.5 3688.2 3714.1 3755.5 3870.3 49273.3 49876.3 49918.0 49965.8 50268.7 9976.4 10025.9 10128.9 10457.8 10519.2 17891.1 17917.9 17944.0 17966.3 17968.4 7417.7 7457.4 7568.4 7571.4 7667.7 4265.7 4286.5 4362.4 4372.9 4421.3 3060.3 3064.6 3088.4 3089.9 3091.7 540.5 556.4 566.5 566.7 573.7 590.7 597.5 628.8 679.3 703.0 8380.5 8419.7 8466.9 8585.5 8613.4 488.5 525.5 588.5 628.1 653.2 3680.2 3911.7 4053.9 4087.6 4190.1 55566.4 55580.2 56109.0 56564.7 59770.7 49581.8 50128.0 50142.0 50160.5 50306.2 45188.2 45679.8 45867.0 45960.5 46104.0 7995.6 8069.9 8208.0 8264.2 8292.2 33713.5 34930.8 34973.5 35137.5 35956.0 43861.3 43938.3 44361.3 44481.6 44957.3 11082.9 11090.5 11399.9 11507.8 11524.6 11622.6 12064.9 12403.8 12455.2 12465.4 11358.0 11528.1 11743.5 11746.8 12104.9 11357.4 11582.9 11656.6 11938.3 11995.7 11136.8 11153.9 11213.3 11246.9 11636.9 8976.2 9000.1 9237.4 9553.6 9633.0 8159.5 8917.1 8917.8 9131.4 9135.9 04:17:49 INFO - 2015-11-20 04:17:49,043 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 04:17:49 INFO - 2015-11-20 04:17:49,043 DEBUG : BROWSER_OUTPUT: 04:17:49 INFO - 2015-11-20 04:17:49,710 INFO : Browser exited with error code: 0 04:17:49 INFO - 2015-11-20 04:17:49,728 INFO : Completed test dromaeo_css (00:18:33) 04:17:49 INFO - 2015-11-20 04:17:49,728 INFO : Starting test kraken 04:17:49 INFO - 2015-11-20 04:17:49,728 DEBUG : operating with platform_type : linux_ 04:17:49 INFO - 2015-11-20 04:17:49,729 INFO : Initialising browser for kraken test... 04:17:49 INFO - 2015-11-20 04:17:49,735 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpyp6wkl/profile http://localhost:39252/getInfo.html 04:17:53 INFO - 2015-11-20 04:17:53,392 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 04:17:53 INFO - 2015-11-20 04:17:53,392 DEBUG : BROWSER_OUTPUT: colorDepth:24 04:17:53 INFO - 2015-11-20 04:17:53,392 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 04:17:53 INFO - 2015-11-20 04:17:53,393 DEBUG : BROWSER_OUTPUT: __metrics 04:17:53 INFO - 2015-11-20 04:17:53,501 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 04:17:54 INFO - 2015-11-20 04:17:54,656 INFO : Browser initialized. 04:17:54 INFO - 2015-11-20 04:17:54,656 INFO : Running cycle 1/1 for kraken test... 04:17:54 INFO - 2015-11-20 04:17:54,656 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpyp6wkl/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 04:18:06 INFO - 2015-11-20 04:18:06,380 DEBUG : BROWSER_OUTPUT: RSS: Main: 139874304 04:18:06 INFO - 2015-11-20 04:18:06,380 DEBUG : BROWSER_OUTPUT: 04:18:08 INFO - 2015-11-20 04:18:08,841 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39252/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:39252/tests/kraken/driver.html?testName=audio-beat-detection) 04:18:09 INFO - 2015-11-20 04:18:09,425 DEBUG : BROWSER_OUTPUT: RSS: Main: 179871744 04:18:09 INFO - 2015-11-20 04:18:09,425 DEBUG : BROWSER_OUTPUT: 04:18:12 INFO - 2015-11-20 04:18:12,022 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39252/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:39252/tests/kraken/driver.html?testName=audio-dft) 04:18:12 INFO - 2015-11-20 04:18:12,589 DEBUG : BROWSER_OUTPUT: RSS: Main: 168148992 04:18:12 INFO - 2015-11-20 04:18:12,590 DEBUG : BROWSER_OUTPUT: 04:18:15 INFO - 2015-11-20 04:18:15,494 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39252/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:39252/tests/kraken/driver.html?testName=audio-fft) 04:18:16 INFO - 2015-11-20 04:18:16,055 DEBUG : BROWSER_OUTPUT: RSS: Main: 151056384 04:18:16 INFO - 2015-11-20 04:18:16,055 DEBUG : BROWSER_OUTPUT: 04:18:18 INFO - 2015-11-20 04:18:18,068 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39252/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:39252/tests/kraken/driver.html?testName=audio-oscillator) 04:18:18 INFO - 2015-11-20 04:18:18,629 DEBUG : BROWSER_OUTPUT: RSS: Main: 153665536 04:18:18 INFO - 2015-11-20 04:18:18,629 DEBUG : BROWSER_OUTPUT: 04:18:20 INFO - 2015-11-20 04:18:20,803 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39252/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:39252/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:18:21 INFO - 2015-11-20 04:18:21,356 DEBUG : BROWSER_OUTPUT: RSS: Main: 155111424 04:18:21 INFO - 2015-11-20 04:18:21,356 DEBUG : BROWSER_OUTPUT: 04:18:24 INFO - 2015-11-20 04:18:24,247 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39252/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:39252/tests/kraken/driver.html?testName=imaging-darkroom) 04:18:24 INFO - 2015-11-20 04:18:24,820 DEBUG : BROWSER_OUTPUT: RSS: Main: 156454912 04:18:24 INFO - 2015-11-20 04:18:24,820 DEBUG : BROWSER_OUTPUT: 04:18:28 INFO - 2015-11-20 04:18:28,179 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39252/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:39252/tests/kraken/driver.html?testName=imaging-desaturate) 04:18:28 INFO - 2015-11-20 04:18:28,746 DEBUG : BROWSER_OUTPUT: RSS: Main: 156270592 04:18:28 INFO - 2015-11-20 04:18:28,746 DEBUG : BROWSER_OUTPUT: 04:18:31 INFO - 2015-11-20 04:18:31,523 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39252/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:39252/tests/kraken/driver.html?testName=json-parse-financial) 04:18:32 INFO - 2015-11-20 04:18:32,096 DEBUG : BROWSER_OUTPUT: RSS: Main: 155746304 04:18:32 INFO - 2015-11-20 04:18:32,097 DEBUG : BROWSER_OUTPUT: 04:18:33 INFO - 2015-11-20 04:18:33,710 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39252/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:39252/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:18:34 INFO - 2015-11-20 04:18:34,271 DEBUG : BROWSER_OUTPUT: RSS: Main: 166248448 04:18:34 INFO - 2015-11-20 04:18:34,271 DEBUG : BROWSER_OUTPUT: 04:18:36 INFO - 2015-11-20 04:18:36,052 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39252/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:39252/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:18:36 INFO - 2015-11-20 04:18:36,641 DEBUG : BROWSER_OUTPUT: RSS: Main: 163028992 04:18:36 INFO - 2015-11-20 04:18:36,641 DEBUG : BROWSER_OUTPUT: 04:18:38 INFO - 2015-11-20 04:18:38,722 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39252/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:39252/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:18:39 INFO - 2015-11-20 04:18:39,296 DEBUG : BROWSER_OUTPUT: RSS: Main: 168800256 04:18:39 INFO - 2015-11-20 04:18:39,296 DEBUG : BROWSER_OUTPUT: 04:18:41 INFO - 2015-11-20 04:18:41,714 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39252/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:39252/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:18:42 INFO - 2015-11-20 04:18:42,295 DEBUG : BROWSER_OUTPUT: RSS: Main: 181821440 04:18:42 INFO - 2015-11-20 04:18:42,295 DEBUG : BROWSER_OUTPUT: 04:18:44 INFO - 2015-11-20 04:18:44,842 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39252/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:39252/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:18:45 INFO - 2015-11-20 04:18:45,411 DEBUG : BROWSER_OUTPUT: RSS: Main: 178380800 04:18:45 INFO - 2015-11-20 04:18:45,411 DEBUG : BROWSER_OUTPUT: 04:18:47 INFO - 2015-11-20 04:18:47,080 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39252/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:39252/tests/kraken/driver.html?testName=ai-astar) 04:18:47 INFO - 2015-11-20 04:18:47,326 DEBUG : BROWSER_OUTPUT: RSS: Main: 237326336 04:18:47 INFO - 2015-11-20 04:18:47,326 DEBUG : BROWSER_OUTPUT: 04:18:47 INFO - 2015-11-20 04:18:47,327 DEBUG : BROWSER_OUTPUT: __start_tp_report 04:18:47 INFO - 2015-11-20 04:18:47,328 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 04:18:47 INFO - 2015-11-20 04:18:47,328 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 04:18:47 INFO - 2015-11-20 04:18:47,328 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 04:18:47 INFO - 2015-11-20 04:18:47,328 DEBUG : BROWSER_OUTPUT: |0;ai-astar;108;110;103;109;111;111;100;108;114;109 04:18:47 INFO - 2015-11-20 04:18:47,328 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;147;125;146;170;125;154;160;129;163;127 04:18:47 INFO - 2015-11-20 04:18:47,328 DEBUG : BROWSER_OUTPUT: |2;audio-dft;161;161;161;161;159;161;161;163;162;165 04:18:47 INFO - 2015-11-20 04:18:47,328 DEBUG : BROWSER_OUTPUT: |3;audio-fft;73;72;83;94;73;73;73;107;93;73 04:18:47 INFO - 2015-11-20 04:18:47,328 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;90;91;138;94;91;92;133;91;90;137 04:18:47 INFO - 2015-11-20 04:18:47,328 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;109;109;109;110;109;109;109;109;109;109 04:18:47 INFO - 2015-11-20 04:18:47,328 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;146;145;146;146;145;146;146;145;145;146 04:18:47 INFO - 2015-11-20 04:18:47,329 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;96;95;96;95;96;96;96;96;96;96 04:18:47 INFO - 2015-11-20 04:18:47,329 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;64;64;63;64;65;63;63;70;64;61 04:18:47 INFO - 2015-11-20 04:18:47,329 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;68;68;68;68;68;69;68;68;69;69 04:18:47 INFO - 2015-11-20 04:18:47,329 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;83;94;87;85;93;85;85;84;87;85 04:18:47 INFO - 2015-11-20 04:18:47,329 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;119;120;124;115;125;121;120;117;125;126 04:18:47 INFO - 2015-11-20 04:18:47,329 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;139;151;148;160;147;147;151;147;160;139 04:18:47 INFO - 2015-11-20 04:18:47,329 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;69;68;67;67;68;66;68;66;66;69 04:18:47 INFO - 2015-11-20 04:18:47,330 DEBUG : BROWSER_OUTPUT: __end_tp_report 04:18:47 INFO - 2015-11-20 04:18:47,330 DEBUG : BROWSER_OUTPUT: __start_cc_report 04:18:47 INFO - 2015-11-20 04:18:47,330 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,885 04:18:47 INFO - 2015-11-20 04:18:47,330 DEBUG : BROWSER_OUTPUT: __end_cc_report 04:18:47 INFO - 2015-11-20 04:18:47,330 DEBUG : BROWSER_OUTPUT: __startTimestamp1448021927326__endTimestamp 04:18:47 INFO - 2015-11-20 04:18:47,330 DEBUG : BROWSER_OUTPUT: 04:18:47 INFO - 2015-11-20 04:18:47,338 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 04:18:47 INFO - 2015-11-20 04:18:47,338 DEBUG : BROWSER_OUTPUT: Number of tests: 14 04:18:47 INFO - 2015-11-20 04:18:47,338 DEBUG : BROWSER_OUTPUT: 04:18:47 INFO - 2015-11-20 04:18:47,338 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:108.30 Median:109.50 stddev:4.06 (3.7%) stddev-sans-first:4.30 04:18:47 INFO - 2015-11-20 04:18:47,338 DEBUG : BROWSER_OUTPUT: Values: 108.0 110.0 103.0 109.0 111.0 111.0 100.0 108.0 114.0 109.0 04:18:47 INFO - 2015-11-20 04:18:47,338 DEBUG : BROWSER_OUTPUT: 04:18:47 INFO - 2015-11-20 04:18:47,338 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:144.60 Median:150.50 stddev:17.12 (11.4%) stddev-sans-first:18.14 04:18:47 INFO - 2015-11-20 04:18:47,338 DEBUG : BROWSER_OUTPUT: Values: 147.0 125.0 146.0 170.0 125.0 154.0 160.0 129.0 163.0 127.0 04:18:47 INFO - 2015-11-20 04:18:47,338 DEBUG : BROWSER_OUTPUT: 04:18:47 INFO - 2015-11-20 04:18:47,338 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:161.50 Median:161.00 stddev:1.58 (1.0%) stddev-sans-first:1.67 04:18:47 INFO - 2015-11-20 04:18:47,338 DEBUG : BROWSER_OUTPUT: Values: 161.0 161.0 161.0 161.0 159.0 161.0 161.0 163.0 162.0 165.0 04:18:47 INFO - 2015-11-20 04:18:47,338 DEBUG : BROWSER_OUTPUT: 04:18:47 INFO - 2015-11-20 04:18:47,338 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:81.40 Median:73.00 stddev:12.44 (17.0%) stddev-sans-first:12.82 04:18:47 INFO - 2015-11-20 04:18:47,339 DEBUG : BROWSER_OUTPUT: Values: 73.0 72.0 83.0 94.0 73.0 73.0 73.0 107.0 93.0 73.0 04:18:47 INFO - 2015-11-20 04:18:47,339 DEBUG : BROWSER_OUTPUT: 04:18:47 INFO - 2015-11-20 04:18:47,339 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:104.70 Median:91.00 stddev:21.66 (23.8%) stddev-sans-first:22.32 04:18:47 INFO - 2015-11-20 04:18:47,339 DEBUG : BROWSER_OUTPUT: Values: 90.0 91.0 138.0 94.0 91.0 92.0 133.0 91.0 90.0 137.0 04:18:47 INFO - 2015-11-20 04:18:47,339 DEBUG : BROWSER_OUTPUT: 04:18:47 INFO - 2015-11-20 04:18:47,339 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:109.10 Median:109.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 04:18:47 INFO - 2015-11-20 04:18:47,339 DEBUG : BROWSER_OUTPUT: Values: 109.0 109.0 109.0 110.0 109.0 109.0 109.0 109.0 109.0 109.0 04:18:47 INFO - 2015-11-20 04:18:47,339 DEBUG : BROWSER_OUTPUT: 04:18:47 INFO - 2015-11-20 04:18:47,339 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:145.60 Median:146.00 stddev:0.52 (0.4%) stddev-sans-first:0.53 04:18:47 INFO - 2015-11-20 04:18:47,339 DEBUG : BROWSER_OUTPUT: Values: 146.0 145.0 146.0 146.0 145.0 146.0 146.0 145.0 145.0 146.0 04:18:47 INFO - 2015-11-20 04:18:47,339 DEBUG : BROWSER_OUTPUT: 04:18:47 INFO - 2015-11-20 04:18:47,339 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:95.80 Median:96.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 04:18:47 INFO - 2015-11-20 04:18:47,339 DEBUG : BROWSER_OUTPUT: Values: 96.0 95.0 96.0 95.0 96.0 96.0 96.0 96.0 96.0 96.0 04:18:47 INFO - 2015-11-20 04:18:47,339 DEBUG : BROWSER_OUTPUT: 04:18:47 INFO - 2015-11-20 04:18:47,339 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:64.10 Median:64.00 stddev:2.33 (3.6%) stddev-sans-first:2.47 04:18:47 INFO - 2015-11-20 04:18:47,339 DEBUG : BROWSER_OUTPUT: Values: 64.0 64.0 63.0 64.0 65.0 63.0 63.0 70.0 64.0 61.0 04:18:47 INFO - 2015-11-20 04:18:47,340 DEBUG : BROWSER_OUTPUT: 04:18:47 INFO - 2015-11-20 04:18:47,340 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:68.30 Median:68.00 stddev:0.48 (0.7%) stddev-sans-first:0.50 04:18:47 INFO - 2015-11-20 04:18:47,340 DEBUG : BROWSER_OUTPUT: Values: 68.0 68.0 68.0 68.0 68.0 69.0 68.0 68.0 69.0 69.0 04:18:47 INFO - 2015-11-20 04:18:47,340 DEBUG : BROWSER_OUTPUT: 04:18:47 INFO - 2015-11-20 04:18:47,340 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:86.80 Median:86.00 stddev:3.74 (4.3%) stddev-sans-first:3.70 04:18:47 INFO - 2015-11-20 04:18:47,340 DEBUG : BROWSER_OUTPUT: Values: 83.0 94.0 87.0 85.0 93.0 85.0 85.0 84.0 87.0 85.0 04:18:47 INFO - 2015-11-20 04:18:47,340 DEBUG : BROWSER_OUTPUT: 04:18:47 INFO - 2015-11-20 04:18:47,340 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:121.20 Median:122.50 stddev:3.71 (3.0%) stddev-sans-first:3.84 04:18:47 INFO - 2015-11-20 04:18:47,340 DEBUG : BROWSER_OUTPUT: Values: 119.0 120.0 124.0 115.0 125.0 121.0 120.0 117.0 125.0 126.0 04:18:47 INFO - 2015-11-20 04:18:47,340 DEBUG : BROWSER_OUTPUT: 04:18:47 INFO - 2015-11-20 04:18:47,340 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:148.90 Median:149.50 stddev:7.17 (4.8%) stddev-sans-first:6.65 04:18:47 INFO - 2015-11-20 04:18:47,340 DEBUG : BROWSER_OUTPUT: Values: 139.0 151.0 148.0 160.0 147.0 147.0 151.0 147.0 160.0 139.0 04:18:47 INFO - 2015-11-20 04:18:47,340 DEBUG : BROWSER_OUTPUT: 04:18:47 INFO - 2015-11-20 04:18:47,340 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.40 Median:68.00 stddev:1.17 (1.7%) stddev-sans-first:1.09 04:18:47 INFO - 2015-11-20 04:18:47,340 DEBUG : BROWSER_OUTPUT: Values: 69.0 68.0 67.0 67.0 68.0 66.0 68.0 66.0 66.0 69.0 04:18:47 INFO - 2015-11-20 04:18:47,341 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 04:18:47 INFO - 2015-11-20 04:18:47,341 DEBUG : BROWSER_OUTPUT: 04:18:48 INFO - 2015-11-20 04:18:48,157 INFO : Browser exited with error code: 0 04:18:48 INFO - 2015-11-20 04:18:48,211 INFO : Completed test kraken (00:00:58) 04:18:48 INFO - 2015-11-20 04:18:48,211 INFO : Starting test v8_7 04:18:48 INFO - 2015-11-20 04:18:48,211 DEBUG : operating with platform_type : linux_ 04:18:48 INFO - 2015-11-20 04:18:48,211 INFO : Initialising browser for v8_7 test... 04:18:48 INFO - 2015-11-20 04:18:48,217 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpc5RcmS/profile http://localhost:39252/getInfo.html 04:18:51 INFO - 2015-11-20 04:18:51,937 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 04:18:51 INFO - 2015-11-20 04:18:51,937 DEBUG : BROWSER_OUTPUT: colorDepth:24 04:18:51 INFO - 2015-11-20 04:18:51,937 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 04:18:51 INFO - 2015-11-20 04:18:51,937 DEBUG : BROWSER_OUTPUT: __metrics 04:18:52 INFO - 2015-11-20 04:18:52,014 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 04:18:53 INFO - 2015-11-20 04:18:53,188 INFO : Browser initialized. 04:18:53 INFO - 2015-11-20 04:18:53,188 INFO : Running cycle 1/1 for v8_7 test... 04:18:53 INFO - 2015-11-20 04:18:53,189 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpc5RcmS/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 04:19:04 INFO - 2015-11-20 04:19:04,986 DEBUG : BROWSER_OUTPUT: RSS: Main: 141688832 04:19:04 INFO - 2015-11-20 04:19:04,987 DEBUG : BROWSER_OUTPUT: 04:19:26 INFO - 2015-11-20 04:19:26,452 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39252/tests/v8_7/run.html (next: http://localhost:39252/tests/v8_7/run.html) 04:19:26 INFO - 2015-11-20 04:19:26,702 DEBUG : BROWSER_OUTPUT: RSS: Main: 593776640 04:19:26 INFO - 2015-11-20 04:19:26,702 DEBUG : BROWSER_OUTPUT: 04:19:26 INFO - 2015-11-20 04:19:26,703 DEBUG : BROWSER_OUTPUT: __start_tp_report 04:19:26 INFO - 2015-11-20 04:19:26,703 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 04:19:26 INFO - 2015-11-20 04:19:26,703 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 04:19:26 INFO - 2015-11-20 04:19:26,704 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 04:19:26 INFO - 2015-11-20 04:19:26,704 DEBUG : BROWSER_OUTPUT: |0;Richards;163.45210853220007 04:19:26 INFO - 2015-11-20 04:19:26,704 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;194.4012441679627 04:19:26 INFO - 2015-11-20 04:19:26,704 DEBUG : BROWSER_OUTPUT: |2;Encrypt;285.7959416976279 04:19:26 INFO - 2015-11-20 04:19:26,704 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5045.226130653266 04:19:26 INFO - 2015-11-20 04:19:26,704 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1949.317738791423 04:19:26 INFO - 2015-11-20 04:19:26,704 DEBUG : BROWSER_OUTPUT: |5;Earley;806.4516129032259 04:19:26 INFO - 2015-11-20 04:19:26,704 DEBUG : BROWSER_OUTPUT: |6;Boyer;12341.463414634147 04:19:26 INFO - 2015-11-20 04:19:26,705 DEBUG : BROWSER_OUTPUT: |7;RegExp;25425 04:19:26 INFO - 2015-11-20 04:19:26,705 DEBUG : BROWSER_OUTPUT: |8;Splay;624.6134817563388 04:19:26 INFO - 2015-11-20 04:19:26,705 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4840.579710144928 04:19:26 INFO - 2015-11-20 04:19:26,705 DEBUG : BROWSER_OUTPUT: __end_tp_report 04:19:26 INFO - 2015-11-20 04:19:26,705 DEBUG : BROWSER_OUTPUT: __startTimestamp1448021966702__endTimestamp 04:19:26 INFO - 2015-11-20 04:19:26,705 DEBUG : BROWSER_OUTPUT: 04:19:26 INFO - 2015-11-20 04:19:26,705 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 04:19:26 INFO - 2015-11-20 04:19:26,706 DEBUG : BROWSER_OUTPUT: Number of tests: 10 04:19:26 INFO - 2015-11-20 04:19:26,706 DEBUG : BROWSER_OUTPUT: 04:19:26 INFO - 2015-11-20 04:19:26,706 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:163.45 Median:163.45 stddev:0.00 (0.0%) 04:19:26 INFO - 2015-11-20 04:19:26,707 DEBUG : BROWSER_OUTPUT: Values: 163.5 04:19:26 INFO - 2015-11-20 04:19:26,707 DEBUG : BROWSER_OUTPUT: 04:19:26 INFO - 2015-11-20 04:19:26,707 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:194.40 Median:194.40 stddev:0.00 (0.0%) 04:19:26 INFO - 2015-11-20 04:19:26,707 DEBUG : BROWSER_OUTPUT: Values: 194.4 04:19:26 INFO - 2015-11-20 04:19:26,707 DEBUG : BROWSER_OUTPUT: 04:19:26 INFO - 2015-11-20 04:19:26,707 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:285.80 Median:285.80 stddev:0.00 (0.0%) 04:19:26 INFO - 2015-11-20 04:19:26,707 DEBUG : BROWSER_OUTPUT: Values: 285.8 04:19:26 INFO - 2015-11-20 04:19:26,707 DEBUG : BROWSER_OUTPUT: 04:19:26 INFO - 2015-11-20 04:19:26,707 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5045.23 Median:5045.23 stddev:0.00 (0.0%) 04:19:26 INFO - 2015-11-20 04:19:26,708 DEBUG : BROWSER_OUTPUT: Values: 5045.2 04:19:26 INFO - 2015-11-20 04:19:26,708 DEBUG : BROWSER_OUTPUT: 04:19:26 INFO - 2015-11-20 04:19:26,708 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1949.32 Median:1949.32 stddev:0.00 (0.0%) 04:19:26 INFO - 2015-11-20 04:19:26,708 DEBUG : BROWSER_OUTPUT: Values: 1949.3 04:19:26 INFO - 2015-11-20 04:19:26,708 DEBUG : BROWSER_OUTPUT: 04:19:26 INFO - 2015-11-20 04:19:26,708 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:806.45 Median:806.45 stddev:0.00 (0.0%) 04:19:26 INFO - 2015-11-20 04:19:26,708 DEBUG : BROWSER_OUTPUT: Values: 806.5 04:19:26 INFO - 2015-11-20 04:19:26,708 DEBUG : BROWSER_OUTPUT: 04:19:26 INFO - 2015-11-20 04:19:26,708 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:12341.46 Median:12341.46 stddev:0.00 (0.0%) 04:19:26 INFO - 2015-11-20 04:19:26,708 DEBUG : BROWSER_OUTPUT: Values: 12341.5 04:19:26 INFO - 2015-11-20 04:19:26,709 DEBUG : BROWSER_OUTPUT: 04:19:26 INFO - 2015-11-20 04:19:26,709 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:25425.00 Median:25425.00 stddev:0.00 (0.0%) 04:19:26 INFO - 2015-11-20 04:19:26,709 DEBUG : BROWSER_OUTPUT: Values: 25425.0 04:19:26 INFO - 2015-11-20 04:19:26,709 DEBUG : BROWSER_OUTPUT: 04:19:26 INFO - 2015-11-20 04:19:26,709 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:624.61 Median:624.61 stddev:0.00 (0.0%) 04:19:26 INFO - 2015-11-20 04:19:26,709 DEBUG : BROWSER_OUTPUT: Values: 624.6 04:19:26 INFO - 2015-11-20 04:19:26,709 DEBUG : BROWSER_OUTPUT: 04:19:26 INFO - 2015-11-20 04:19:26,709 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4840.58 Median:4840.58 stddev:0.00 (0.0%) 04:19:26 INFO - 2015-11-20 04:19:26,709 DEBUG : BROWSER_OUTPUT: Values: 4840.6 04:19:26 INFO - 2015-11-20 04:19:26,709 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 04:19:26 INFO - 2015-11-20 04:19:26,709 DEBUG : BROWSER_OUTPUT: 04:19:27 INFO - 2015-11-20 04:19:27,553 INFO : Browser exited with error code: 0 04:19:27 INFO - 2015-11-20 04:19:27,572 INFO : Completed test v8_7 (00:00:39) 04:19:27 INFO - 2015-11-20 04:19:27,647 INFO : Completed test suite (00:20:11) 04:19:27 INFO - 2015-11-20 04:19:27,647 DEBUG : Working with test: dromaeo_css 04:19:27 INFO - 2015-11-20 04:19:27,647 DEBUG : Generating results file: dromaeo_css 04:19:27 INFO - 2015-11-20 04:19:27,648 DEBUG : Working with test: kraken 04:19:27 INFO - 2015-11-20 04:19:27,649 DEBUG : Generating results file: kraken 04:19:27 INFO - 2015-11-20 04:19:27,649 INFO : javascript benchmark 04:19:27 INFO - 2015-11-20 04:19:27,649 DEBUG : Working with test: v8_7 04:19:27 INFO - 2015-11-20 04:19:27,649 DEBUG : Generating results file: v8_7 04:19:27 INFO - 2015-11-20 04:19:27,650 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 04:19:27 INFO - 2015-11-20 04:19:27,699 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,201,35]] 04:19:27 INFO - 2015-11-20 04:19:27,699 DEBUG : process_Request line: dromaeo_css 7066.97 graph.html#tests=[[72,201,35]] 04:19:27 INFO - 2015-11-20 04:19:27,699 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 04:19:27 INFO - 2015-11-20 04:19:27,734 DEBUG : process_Request line: kraken 1507.70 graph.html#tests=[[232,201,35]] 04:19:27 INFO - 2015-11-20 04:19:27,735 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 04:19:27 INFO - 2015-11-20 04:19:27,762 DEBUG : process_Request line: v8_7 19765.09 graph.html#tests=[[230,201,35]] 04:19:27 INFO - 2015-11-20 04:19:27,764 INFO : javascript benchmark 04:19:27 INFO - 2015-11-20 04:19:27,767 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3147.8898238561646, 3196.2169268529215, 3237.7409807215427, 3246.220906982325, 3255.8209298488587, 5347.171188465784, 5393.352797664281, 5466.917996230055, 5477.1510415885505, 5479.917801232985, 5264.868378290545, 5335.599830012745, 5380.24676545284, 5388.353397592295, 5431.755570999305, 4963.081829861479, 4989.950100498985, 4991.151504244287, 5015.348004759376, 5079.568236699885, 5098.974505127488, 5146.794128234867, 5192.376914770233, 5211.843644690665, 5215.1655735082395, 4902.142125128088, 4911.58251548617, 4991.450940396553, 5045.217991211368, 5064.670796398241, 4931.556159945586, 4933.038057578774, 4957.5786058185095, 4978.626603004789, 5017.0, 4889.804407823683, 4901.240307752304, 4907.11671899058, 4913.238448040559, 4951.133551628451, 5193.350831146106, 5255.264263003182, 5303.098473259555, 5344.5724342052545, 5425.0, 5845.941540584582, 5874.618149820248, 5890.293164820249, 5903.144044113623, 5982.910256346158, 5905.970470147665, 5910.468057874769, 5926.318473375574, 5932.169496270526, 5937.139114828326, 5414.83755487336, 5429.972850135763, 5503.834884953458, 5504.4770746778995, 5506.33923929123, 5923.141144534018, 5923.466887980103, 5955.374685657944, 5958.523318134538, 6007.068904319837, 5706.8871570044275, 5735.627184233012, 5738.569607279471, 5739.053056245756, 5813.186153938452, 5732.05421105513, 5791.797287095016, 5832.416758324219, 5851.765929362778, 5855.560832937546, 5857.619254748428, 5936.7031648417405, 5941.821745347646, 5988.820335389945, 5990.251218597676, 5851.32709738377, 5970.671613061323, 5982.282126144803, 5983.640981541034, 5988.341282458926, 4327.870163895088, 4550.97724511382, 4579.22153233951, 4586.4496260448295, 4604.88487787808, 3968.642822145963, 3979.045029192973, 4030.234255491506, 4044.939325910114, 4081.285774989365, 5513.283273174462, 5570.3315602127195, 5574.219609254707, 5575.832725018256, 5579.9163012554845, 5927.73325200367, 5938.732757025944, 5965.910511342333, 5970.671613061323, 5972.492338151219, 5373.973130134403, 5382.569394448513, 5478.91781623276, 5480.6437581557075, 5511.779528818883, 5140.897182056338, 5193.584513238932, 5196.818111366084, 5197.038547868657, 5211.687298762086, 6104.542159338156, 6117.938820611737, 6118.1434599156155, 6123.540734444934, 6124.265088189357, 5747.971260143672, 5860.472557469678, 5862.032764593794, 5901.350851406428, 6053.122297266959, 6152.930675394121, 6197.132401463708, 6198.907016394667, 6211.503079753699, 6211.689415529115, 5849.912251316318, 5902.852428689145, 5903.439173278532, 5917.0, 5964.373740757158, 5834.27071616048, 5857.9121313179485, 5904.261967254093, 5917.37867523921, 5976.073708575178, 5788.9131663024245, 5832.008558544972, 5834.533237340917, 5838.737256823369, 5841.153032810304, 5794.420557944172, 5843.152742852348, 5851.414858514115, 5853.707314634336, 5859.824205273849, 5490.80782172622, 5599.412061733459, 5646.2942132233475, 5690.630109042899, 5760.683162426107, 5685.658860468385, 5701.686407247641, 5715.8856822864145, 5725.627834190765, 5776.797812076557, 5614.382417933943, 5614.887702246014, 5623.297087864017, 5623.943760562342, 5633.718314084197], "unit": "ms", "name": "dojo.html", "value": 5425.161230956927}, {"lowerIsBetter": false, "replicates": [553.2424298789068, 589.8112603966731, 593.7803012885233, 604.9727762250699, 608.7473698415158, 31021.689783102163, 39070.804645976765, 40094.59905400945, 40108.1978360433, 40151.799241003755, 41291.38062929059, 41829.0, 41833.16333673332, 41864.37203441951, 41966.790166049206, 7645.885311720329, 7754.1470438251745, 8854.778630534223, 9047.502387368691, 10290.382577045364, 10522.842157367646, 10623.521941512612, 10679.679609611685, 10681.572737090508, 10692.518836652369, 10536.78926421471, 10573.101286390665, 10599.576016959312, 10626.521806518725, 10631.468426578678, 7780.727674531393, 8018.238267364562, 10696.518656660392, 10937.179711521589, 10948.616798412017, 10463.84304235437, 10513.789724205473, 10545.31455455393, 10564.630237941636, 10568.841467377995, 39666.80166599178, 40132.59867401318, 40161.0, 40181.79909100436, 40198.59801401978, 3384.5769278840144, 3424.07549961509, 3552.3960926642276, 3736.3648179809497, 4074.2258970795456, 29591.408171836658, 29896.355700436467, 29914.85042574795, 30087.247818804488, 30382.088537343916, 3937.0944682722848, 3946.605339466059, 4042.2925987952285, 4108.4453598764385, 4149.730267532601, 273306.0, 274719.0, 275029.0, 275754.0, 276056.0, 54000.45999540033, 54783.178252326245, 61212.38787612156, 68065.3193468069, 68924.65537672279, 63329.36670633327, 63406.68296658487, 63544.364556353845, 63562.68218658877, 63698.68150659217, 14220.21788801626, 14373.64065898361, 14381.424743010371, 14386.496472623618, 14412.207328596818, 11778.0, 12040.879591204151, 12041.879581204075, 12045.156839021185, 12110.333931633844, 20231.4942126448, 20625.278115266196, 20700.171993120406, 20718.477858764047, 20726.378208653765, 8001.239882211181, 8005.759827205193, 8092.554909479917, 8189.754307370788, 8196.180381961876, 920.2408013388981, 993.5032483758121, 1039.5062345385882, 1042.3329069395593, 1146.7706458708292, 28154.718452815618, 28665.85667071693, 28986.710132898825, 29194.7080529192, 32844.83577582097, 1025.251566356549, 1044.8850626431085, 1046.570905928581, 1064.9627263045757, 1149.781541507111, 16610.75083873743, 17377.0, 17490.21294041771, 17491.12544372802, 17518.824811751972, 353111.0, 358540.0, 360017.0, 360711.0, 360921.0, 55099.449005510236, 55314.44685553093, 55496.44503554913, 55561.44438555644, 55615.44384556184, 1337.0774165825549, 1349.1770020287618, 1374.29223949666, 1374.587623712882, 1383.5503461375092, 29005.56491652669, 30022.699773002863, 30612.846935765177, 31040.68959310378, 32839.292934839235, 49258.0, 49886.750566246934, 49921.0, 50086.749566251936, 50116.749416252685, 299380.0, 300019.0, 302612.0, 302913.0, 303892.0, 27929.301767455978, 28517.572236416887, 31099.0, 31743.0, 32739.0, 38710.612893870704, 38842.61157388503, 39674.0, 39768.403473947335, 39773.0, 35106.29787404186, 35784.0, 35995.82002090078, 36234.637653623126, 36532.269354613294, 35995.64004360027, 36316.455253170694, 36590.634093659784, 36741.44887826631, 36769.448458272615, 35159.64840351666, 35441.82279088588, 35840.46239306465, 35866.0, 35882.64117358793, 30523.2369190772, 31746.52380214345, 32929.835350823094, 33066.504002440466, 33174.0, 24650.753492465563, 25054.62418063694, 25240.747592524574, 25521.61717574275, 26783.0], "unit": "ms", "name": "ext.html", "value": 19224.03457288211}, {"lowerIsBetter": false, "replicates": [347.85216283079683, 349.4722968317839, 354.29848899179626, 361.8697268983166, 362.9201575653356, 15246.618834529143, 15303.540893773177, 16436.424725134624, 17211.913940430295, 18207.817921820777, 16054.277557509911, 16592.08743519106, 17230.82769172308, 17777.91111044443, 17781.11094445279, 4342.392065110887, 4910.680805747633, 4913.877153071184, 4916.926246106311, 4918.704877707349, 3759.266942946113, 3884.5726970033274, 4840.782164802592, 4868.707877527342, 5162.328897243353, 5280.128778751501, 5320.866978325535, 5323.361196656407, 5340.813071542497, 5343.171808369709, 4998.825041123561, 5200.0, 5203.453637368098, 5266.789328426858, 5298.682079075268, 4907.631927605408, 5000.874978125539, 5013.172826483662, 5014.473480284554, 5028.698278103326, 11729.70675733105, 11877.643670689893, 11945.462454189583, 11952.163348565604, 13732.45070197191, 2114.6722258050027, 2116.460302622837, 2124.4264048706764, 2137.9893100534396, 2151.4621344663833, 9040.68357607487, 9359.344845860793, 9562.90437095627, 11474.942625286903, 12575.742425757442, 1748.6240458301527, 1759.780027496563, 1769.6018395860956, 1816.8001519832808, 1862.5995410986568, 59682.0, 62625.37374626286, 63281.36718632801, 63366.0, 63581.0, 9803.852942205873, 9942.950285248528, 10100.696979090639, 10107.444090574942, 10165.440900750382, 13507.257100859548, 13524.864751352558, 13536.729265414637, 13538.0, 13538.932305338607, 7240.2035776064595, 7526.435517336222, 7577.052868391451, 7618.047744031996, 7791.337736292478, 6859.7256109756045, 6948.965255173692, 6954.895676564855, 7048.189458212269, 7400.9629951850975, 4165.812538435777, 4278.893027674333, 4381.802818873159, 4408.58118478744, 4438.667099967515, 1651.157909466157, 1717.1414292853574, 1766.5406994181606, 1839.1264149529134, 2981.1652737233608, 873.4802792338548, 888.4757992784288, 905.968291109808, 962.9759256018516, 1058.3914249306679, 16165.919170404073, 16843.242054107595, 17237.741433878502, 17266.0, 17467.737983930252, 924.9260059195249, 964.7057647417605, 973.868527748759, 981.5435822342645, 1009.3086235928413, 9688.612455501701, 10177.440240786827, 10215.13171380441, 10388.896111038945, 10432.478376081166, 514345.0, 519061.0, 520536.0, 524978.0, 529681.0, 76086.6195669018, 79022.67818574615, 79311.0, 79548.20451795524, 80166.0, 1096.0519150934385, 1096.4627332606965, 1140.4468832616174, 1144.9313041217554, 1161.6573110932295, 15651.0, 15732.685346292781, 15745.44890928812, 15797.605059873595, 16102.0, 35898.0, 36352.63647363493, 36434.0, 37462.62537374591, 38150.809245954704, 43124.0, 45319.773401132785, 47777.28334075061, 48330.275045873634, 48351.0, 9011.0, 9284.118008789153, 9294.907050929403, 9301.72094837156, 9303.860442093239, 10749.838752418564, 10811.837822432513, 13430.93284533571, 17001.149942503074, 17407.21667524939, 11534.94232528832, 11786.823197652213, 12373.505059797868, 12902.870971290167, 14966.775498367751, 13920.58238252854, 14070.0, 14089.788653170415, 14550.4907328243, 14622.195779232245, 14592.635184120481, 14598.051126676732, 14670.926645366704, 14706.852931470548, 14935.626609334418, 8975.37172397952, 9225.354225204172, 9237.861432078389, 9987.500624968578, 10041.347312424668, 11572.421378931189, 14423.49517766873, 14643.56069317922, 14999.2500374983, 15020.248987550798], "unit": "ms", "name": "jquery.html", "value": 8638.924698396833}, {"lowerIsBetter": false, "replicates": [1360.2926478231327, 1714.9657006859863, 1746.231658070449, 1766.108115401722, 1777.6580029544455, 7090.078289822322, 7361.9631901840485, 7408.814779630512, 7415.592142432164, 7429.182789893108, 7602.77191684249, 7753.883691744614, 7766.0, 7772.650230739616, 7788.221177882209, 2064.2465500092435, 2094.120469402847, 2096.4968407582223, 2303.401115709919, 2322.6864373309554, 2313.8611683299055, 2358.740538540759, 2359.09174967637, 2360.4334959609655, 2363.196513185517, 2197.3957161780477, 2210.745764237109, 2274.2040285899884, 2274.317704688595, 2277.487565297811, 2016.4555569996091, 2066.6693329067275, 2069.834413246944, 2254.030766770288, 2294.713160854893, 2177.575372802304, 2179.56408718257, 2182.1053368119155, 2182.1162429216033, 2182.1162429216192, 7624.656890439944, 7757.573333466714, 7762.184970578121, 7770.6114694265625, 7776.572288524129, 4690.906181876378, 4758.3576217210575, 4764.166270902579, 4773.952260477386, 4774.427068751737, 3086.182161727144, 3092.8144311341393, 3166.889158879428, 3174.8095114292987, 3200.0399880035898, 1017.5471914997829, 1023.3399457350042, 1037.901399367059, 1046.1839764983324, 1064.0370464729356, 10592.099671527929, 10601.363918164934, 10613.150947924147, 10650.4142272175, 10702.946485267525, 4250.149970005949, 4328.09110086879, 4361.367601697736, 4366.061296821135, 4379.802908869108, 9119.316051296046, 9121.179093881583, 9165.862512062324, 9176.541172941459, 9187.173154416001, 4744.976275118603, 4745.3593764842, 4775.617950563947, 4779.808807647655, 4782.784774685148, 4287.892802679896, 4320.287152619782, 4328.458942632171, 4328.761918094535, 4336.804843782037, 3723.646253605903, 3777.0934975605655, 3810.657040866335, 3839.6352346527037, 3840.0399900024995, 1211.7213041000443, 1219.152688881219, 1221.4137214137086, 1230.194222784078, 1231.7474917641862, 1047.858539097212, 1063.0857462582173, 1063.2238465919922, 1212.7150119721857, 1356.4777560639225, 7185.89221161683, 7235.335872749192, 7252.709891604277, 7252.854942901113, 7594.962025189839, 1055.055725126008, 1080.9297395669257, 1094.655183617158, 1149.3448734221581, 1157.427073598574, 5605.607607467519, 5738.483536481654, 6053.848653783691, 6197.907031394533, 6199.783007594712, 9182.540872956326, 9222.538873056454, 9529.809403811885, 9576.952115239379, 9588.041195880496, 9475.810483790285, 9478.431294122236, 9525.761855953657, 9535.0, 9565.426074435556, 7107.573545587281, 7240.782776516713, 7246.891296630555, 7274.090738657668, 7442.627868606548, 7444.962775186089, 7595.658195381332, 7614.352780013539, 7614.733484328022, 7627.733029343946, 8332.458390204618, 8457.873131902903, 8729.3889427742, 8765.386422950587, 8787.692430764893, 8674.956625216833, 8690.0, 8711.172438618321, 8803.0, 8865.069167737294, 7058.364747172779, 7160.820979475555, 7166.641667916688, 7184.820379490555, 7191.928080719126, 7545.886811697719, 7574.3183113520045, 7592.16486186508, 7592.924070759222, 7597.164311925573, 6733.0573719678305, 7031.0, 7125.0, 7239.914012898107, 7307.415406767552, 6732.293109223657, 6823.89764153548, 6846.7945961621235, 6880.58716477013, 6915.273896240822, 6863.553868998499, 6985.720571177096, 6986.755463558751, 6998.40513556333, 7039.718411263492, 6561.704723287368, 6597.406233439014, 6615.735370585123, 6627.105340778933, 6636.170478690164, 6051.4553690168095, 6156.507479401547, 6159.4456498915315, 6474.741010359721, 6530.8367290818105], "unit": "ms", "name": "mootools.html", "value": 4520.957215891961}, {"lowerIsBetter": false, "replicates": [325.51660783736156, 329.5764942049465, 329.981850998195, 331.3588206819803, 335.855582099697, 6104.1759362486055, 6138.846528836776, 6159.0, 6170.444659980601, 6191.226096737908, 5863.76544938202, 5947.107933809931, 6010.8797824043495, 6070.332263451028, 6099.024156135019, 4650.651201159918, 4658.114958157939, 4668.393108895839, 4680.25115981443, 4702.153612349775, 4468.218061839181, 4697.88255293617, 4707.482176960531, 4711.92932106017, 4714.5521175488275, 4517.4804897436725, 4521.457425108992, 4662.650301227422, 4669.112868554981, 4681.39141911551, 4627.259638457831, 4634.768261586907, 4653.464851542049, 4655.976720116395, 4662.836800711959, 4082.2243773682903, 4084.938725919084, 4085.55058943516, 4086.6322031017353, 4088.264112459786, 5724.141378793172, 5804.941950580483, 5819.73811178498, 5822.126680997884, 5822.505087067604, 5385.461453854622, 5386.622936394454, 5402.810901618424, 5403.51368376844, 5403.540699040586, 6464.903026454607, 6489.091527186198, 6499.447546958514, 6500.837479063014, 6503.6097834130105, 4419.911601767946, 4429.601335879786, 4429.822807087713, 4430.556944305576, 4430.579094985971, 6567.507436942248, 6643.966780166068, 6689.732410703566, 6699.531032827704, 6702.262751097375, 4514.706544074625, 4523.773811309421, 4524.04994951064, 4525.502194758574, 4527.1398434298035, 4572.222722137245, 4572.382728331632, 4572.9314060289125, 4587.311903214544, 4588.151192029485, 5351.224072509543, 5357.366003368932, 5363.302770639792, 5363.892722145535, 5370.489803468664, 6381.8085457436355, 6524.314946930599, 6526.771562995273, 6527.738890444424, 6530.575512591761, 1599.5441299229665, 1619.6598714270135, 1622.4970259219679, 1623.5048310265483, 1624.3177865296605, 1062.930909490896, 1070.1064611049705, 1072.1583556907947, 1087.472575800736, 1091.476091476096, 6237.4698150657705, 6239.344868788802, 6241.999999999909, 6244.0, 6245.687715614292, 6514.348565143542, 6698.497612679069, 6716.496262780311, 6717.865642687118, 6728.764493242713, 6138.508919286446, 6162.907556386658, 6285.622862628165, 6292.307846136921, 6300.464460520907, 3612.187257866959, 3647.8905632831056, 3652.1782598915033, 3654.287413954253, 3668.926621467556, 6812.318768123148, 6986.37122658953, 6986.930130698628, 6993.0, 6993.2657071007825, 6947.166340039126, 6951.860962780716, 6954.061201737802, 6955.582665040114, 6958.0, 6972.058772065706, 6983.580985140908, 6990.405815505739, 6997.405220556309, 7000.194977577542, 6610.735570577123, 6741.258461569126, 6741.2921643226755, 6747.190337159573, 6753.3921947025, 6613.503987200883, 6644.83387915306, 6686.7993960181275, 6697.162854643169, 6701.195856497252, 6979.54632948877, 6997.580145191305, 7008.789736307919, 7018.75434359795, 7020.929790702027, 4393.406890069799, 4470.351798989193, 4492.73043617384, 4499.77501124949, 4502.302143167683, 6733.158355205599, 6733.797986060426, 6739.460843132636, 6746.0, 6747.898781518379, 6532.706028228646, 6534.379233972765, 6543.5419520633095, 6546.509011824037, 6547.869042619216, 6395.7121929514215, 6497.4477169441125, 6540.215174179129, 6546.116274302908, 6552.967235163794, 6410.8076757697345, 6415.711292991733, 6422.165118534747, 6424.807255782334, 6427.292997770335, 6531.510136739668, 6566.343365663586, 6584.934150658432, 6586.967065164835, 6601.207855057231, 6330.465677957578, 6406.903896441464, 6422.068800023877, 6429.453496452854, 6435.066915297162], "unit": "ms", "name": "prototype.html", "value": 4881.099884597479}, {"lowerIsBetter": false, "replicates": [759.6923246085333, 841.8063845315577, 854.4232642965999, 857.6097875466663, 870.1211776106131, 12867.356632168388, 13192.340382980849, 13209.735805283888, 13215.669608259786, 13221.735565288689, 12972.675683107927, 13055.60833175004, 13067.21596704196, 13075.084744067919, 13090.280034598094, 676.7868121541699, 680.7549282258383, 817.648411183191, 818.4107442641289, 830.8338332333527, 832.142892820396, 832.1595188859235, 838.8741688746676, 840.1220724343076, 840.6553313141613, 863.3740538109882, 867.5705525764755, 873.4933738431727, 875.0986483921571, 876.7457437343163, 715.2454160860291, 716.7849645106473, 852.2542775071781, 865.277493293101, 866.2636758755008, 633.7338317906444, 635.1108448172549, 638.1162090504685, 638.2883085359837, 639.6673729660597, 13171.078024538287, 13308.134971226838, 13324.200547967055, 13355.399007044609, 13371.064025518217, 12018.879811201863, 12154.027677785843, 12366.319852408114, 12420.130590858644, 12488.562900298446, 10231.641892533726, 10259.692209233735, 10284.331518451352, 10490.527926243338, 10646.627368042158, 3679.5400574928135, 3688.188598508324, 3714.0900479382453, 3755.5493340799007, 3870.322693528621, 49273.260901086156, 49876.25185622219, 49918.00163996736, 49965.750171249274, 50268.74865625685, 9976.351537150062, 10025.949870250748, 10128.898711012796, 10457.84313235302, 10519.21105917044, 17891.105444727713, 17917.910410447865, 17944.0, 17966.281348745903, 17968.371107011455, 7417.703291868373, 7457.366123879422, 7568.394528437711, 7571.3942884569105, 7667.731629392944, 4265.658747300271, 4286.5284818669925, 4362.389265502832, 4372.934405983913, 4421.314696222091, 3060.296131889678, 3064.6169228846393, 3088.4286407014774, 3089.876404943822, 3091.6599174090834, 540.5459414092103, 556.4018679919103, 566.4731799426573, 566.6854895533019, 573.6988081257373, 590.7253127295828, 597.5279529171905, 628.7547856336032, 679.3308591037824, 703.033329172388, 8380.539070351067, 8419.705310314232, 8466.915330846736, 8585.484870907641, 8613.353998450142, 488.50172823719606, 525.542777783331, 588.5085953229102, 628.0704557255287, 653.1867824558456, 3680.247344536945, 3911.6675082618294, 4053.8783836484363, 4087.570805065485, 4190.057237121623, 55566.44433555612, 55580.16629750557, 56109.0, 56564.71717641468, 59770.701146493986, 49581.752091239316, 50128.0, 50142.0, 50160.498395016315, 50306.245406318936, 45188.15900648482, 45679.77160114178, 45867.0, 45960.54039459563, 46104.0, 7995.640196191302, 8069.87895181561, 8207.95896020516, 8264.198788023894, 8292.212239837207, 33713.494297585064, 34930.825345873105, 34973.47539786854, 35137.47293790647, 35956.0, 43861.342079869464, 43938.34092488551, 44361.33457998068, 44481.55518444903, 44957.325640116076, 11082.944585277022, 11090.500927458123, 11399.886001139883, 11507.827382589101, 11524.59663911759, 11622.593209237637, 12064.879351206375, 12403.75192496163, 12455.190412623151, 12465.376731163224, 11358.0, 11528.07775377951, 11743.471543780379, 11746.823797642872, 12104.878951210727, 11357.432128393382, 11582.884171158517, 11656.592019279284, 11938.343391113573, 11995.700107497383, 11136.832947505633, 11153.888461115284, 11213.327200368005, 11246.943765281121, 11636.94181529087, 8976.237019853386, 9000.144986226298, 9237.445753254826, 9553.570089346134, 9632.95183524078, 8159.46963447374, 8917.063708310534, 8917.821643567222, 9131.405337532213, 9135.908640913505], "unit": "ms", "name": "yui.html", "value": 6264.66102761808}], "name": "dromaeo_css", "value": 7066.974343903849}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [108.0, 110.0, 103.0, 109.0, 111.0, 111.0, 100.0, 108.0, 114.0, 109.0], "unit": "ms", "name": "ai-astar", "value": 108.3}, {"lowerIsBetter": true, "replicates": [147.0, 125.0, 146.0, 170.0, 125.0, 154.0, 160.0, 129.0, 163.0, 127.0], "unit": "ms", "name": "audio-beat-detection", "value": 144.6}, {"lowerIsBetter": true, "replicates": [161.0, 161.0, 161.0, 161.0, 159.0, 161.0, 161.0, 163.0, 162.0, 165.0], "unit": "ms", "name": "audio-dft", "value": 161.5}, {"lowerIsBetter": true, "replicates": [73.0, 72.0, 83.0, 94.0, 73.0, 73.0, 73.0, 107.0, 93.0, 73.0], "unit": "ms", "name": "audio-fft", "value": 81.4}, {"lowerIsBetter": true, "replicates": [90.0, 91.0, 138.0, 94.0, 91.0, 92.0, 133.0, 91.0, 90.0, 137.0], "unit": "ms", "name": "audio-oscillator", "value": 104.7}, {"lowerIsBetter": true, "replicates": [109.0, 109.0, 109.0, 110.0, 109.0, 109.0, 109.0, 109.0, 109.0, 109.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 109.1}, {"lowerIsBetter": true, "replicates": [146.0, 145.0, 146.0, 146.0, 145.0, 146.0, 146.0, 145.0, 145.0, 146.0], "unit": "ms", "name": "imaging-darkroom", "value": 145.6}, {"lowerIsBetter": true, "replicates": [96.0, 95.0, 96.0, 95.0, 96.0, 96.0, 96.0, 96.0, 96.0, 96.0], "unit": "ms", "name": "imaging-desaturate", "value": 95.8}, {"lowerIsBetter": true, "replicates": [64.0, 64.0, 63.0, 64.0, 65.0, 63.0, 63.0, 70.0, 64.0, 61.0], "unit": "ms", "name": "json-parse-financial", "value": 64.1}, {"lowerIsBetter": true, "replicates": [68.0, 68.0, 68.0, 68.0, 68.0, 69.0, 68.0, 68.0, 69.0, 69.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 68.3}, {"lowerIsBetter": true, "replicates": [83.0, 94.0, 87.0, 85.0, 93.0, 85.0, 85.0, 84.0, 87.0, 85.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 86.8}, {"lowerIsBetter": true, "replicates": [119.0, 120.0, 124.0, 115.0, 125.0, 121.0, 120.0, 117.0, 125.0, 126.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 121.2}, {"lowerIsBetter": true, "replicates": [139.0, 151.0, 148.0, 160.0, 147.0, 147.0, 151.0, 147.0, 160.0, 139.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 148.9}, {"lowerIsBetter": true, "replicates": [69.0, 68.0, 67.0, 67.0, 68.0, 66.0, 68.0, 66.0, 66.0, 69.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 67.4}], "name": "kraken", "value": 1507.7000000000003}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [163.45210853220007], "unit": "score", "name": "Richards", "value": 215.97763600000008}, {"lowerIsBetter": false, "replicates": [194.4012441679627], "unit": "score", "name": "DeltaBlue", "value": 340.110992}, {"lowerIsBetter": false, "replicates": [285.7959416976279], "unit": "score", "name": "Encrypt", "value": 931.3673189999998}, {"lowerIsBetter": false, "replicates": [5045.226130653266], "unit": "score", "name": "Decrypt", "value": 52.75898306772911}, {"lowerIsBetter": false, "replicates": [1949.317738791423], "unit": "score", "name": "RayTrace", "value": 379.61435700000015}, {"lowerIsBetter": false, "replicates": [806.4516129032259], "unit": "score", "name": "Earley", "value": 826.4141199999997}, {"lowerIsBetter": false, "replicates": [12341.463414634147], "unit": "score", "name": "Boyer", "value": 54.00194268774702}, {"lowerIsBetter": false, "replicates": [25425.0], "unit": "score", "name": "RegExp", "value": 35.83028515240902}, {"lowerIsBetter": false, "replicates": [624.6134817563388], "unit": "score", "name": "Splay", "value": 130.46628415841582}, {"lowerIsBetter": false, "replicates": [4840.579710144928], "unit": "score", "name": "NavierStokes", "value": 306.5748502994012}], "name": "v8_7", "value": 19765.0891704636}]} 04:19:27 INFO - RETURN: dromaeo_css: 7066.97 04:19:27 INFO - RETURN: kraken: 1507.70 04:19:27 INFO - RETURN: v8_7: 19765.09 04:19:27 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,201,35]]", "result": "19765.09"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,201,35]]", "result": "1507.70"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,201,35]]", "result": "7066.97"}}} 04:19:27 INFO - Return code: 0 04:19:27 INFO - # TBPL SUCCESS # 04:19:27 INFO - Running post-action listener: _resource_record_post_action 04:19:27 INFO - Running post-run listener: _resource_record_post_run 04:19:28 INFO - Total resource usage - Wall time: 1226s; CPU: 13.0%; Read bytes: 4096; Write bytes: 502599680; Read time: 16; Write time: 433356 04:19:28 INFO - install - Wall time: 15s; CPU: 14.0%; Read bytes: 0; Write bytes: 208879616; Read time: 0; Write time: 255760 04:19:28 INFO - run-tests - Wall time: 1212s; CPU: 13.0%; Read bytes: 4096; Write bytes: 272625664; Read time: 16; Write time: 133956 04:19:28 INFO - Running post-run listener: _upload_blobber_files 04:19:28 INFO - Blob upload gear active. 04:19:28 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 04:19:28 INFO - Copying logs to upload dir... 04:19:28 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1255.334236 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 55 secs) (at 2015-11-20 04:19:28.823432) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-20 04:19:28.826469) ========= 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=d6a7e047ef025f707024e163000001c3-1448020680.460833-619040387 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/ATdGB3SPQFWzVMJWZk27Xw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.009967 build_url: 'https://queue.taskcluster.net/v1/task/ATdGB3SPQFWzVMJWZk27Xw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2' ========= master_lag: 0.04 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-20 04:19:28.877844) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-20 04:19:28.878185) ========= 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=d6a7e047ef025f707024e163000001c3-1448020680.460833-619040387 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004574 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-20 04:19:28.927936) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-20 04:19:28.928269) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-20 04:19:28.928565) ========= ========= Total master_lag: 0.27 =========