builder: b2g-inbound_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-063 starttime: 1448376683.16 results: success (0) buildid: 20151124053007 builduid: 4e8d471afd544f5ba49a360c988e0e39 revision: 5a6b4eae6d8e2d67b0c50fe84ed30b4794bf25ea ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-11-24 06:51:23.164729) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-11-24 06:51:23.165225) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-24 06:51:23.165526) ========= 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=edca6ca23558fe0608d91a4e00000196-1448376508.945868-1650807499 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006394 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.19 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-24 06:51:23.366734) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-24 06:51:23.367131) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-24 06:51:23.382166) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-24 06:51:23.382464) ========= 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=edca6ca23558fe0608d91a4e00000196-1448376508.945868-1650807499 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004691 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-24 06:51:23.439166) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-24 06:51:23.439689) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-24 06:51:23.440248) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-24 06:51:23.440724) ========= 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=edca6ca23558fe0608d91a4e00000196-1448376508.945868-1650807499 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-11-24 06:51:24-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 43.1M=0s 2015-11-24 06:51:24 (43.1 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.165579 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-24 06:51:23.619637) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-24 06:51:23.620025) ========= 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=edca6ca23558fe0608d91a4e00000196-1448376508.945868-1650807499 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017200 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-24 06:51:23.669915) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-24 06:51:23.670282) ========= bash -c 'python archiver_client.py mozharness --repo integration/b2g-inbound --rev 5a6b4eae6d8e2d67b0c50fe84ed30b4794bf25ea --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 5a6b4eae6d8e2d67b0c50fe84ed30b4794bf25ea --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=edca6ca23558fe0608d91a4e00000196-1448376508.945868-1650807499 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-11-24 06:51:24,821 truncating revision to first 12 chars 2015-11-24 06:51:24,821 Setting DEBUG logging. 2015-11-24 06:51:24,821 attempt 1/10 2015-11-24 06:51:24,821 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/b2g-inbound/5a6b4eae6d8e?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-11-24 06:51:25,082 unpacking tar archive at: b2g-inbound-5a6b4eae6d8e/testing/mozharness/ program finished with exit code 0 elapsedTime=0.550134 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-24 06:51:24.233503) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-24 06:51:24.233885) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-24 06:51:24.244731) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-24 06:51:24.245103) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-24 06:51:24.245556) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 55 secs) (at 2015-11-24 06:51:24.245845) ========= /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=edca6ca23558fe0608d91a4e00000196-1448376508.945868-1650807499 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 06:51:25 INFO - MultiFileLogger online at 20151124 06:51:25 in /builds/slave/test-pgo 06:51:25 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name B2G-Inbound --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch B2G-Inbound 06:51:25 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 06:51:25 INFO - {'append_to_log': False, 06:51:25 INFO - 'base_work_dir': '/builds/slave/test-pgo', 06:51:25 INFO - 'blob_upload_branch': 'B2G-Inbound', 06:51:25 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 06:51:25 INFO - 'branch': 'B2G-Inbound', 06:51:25 INFO - 'buildbot_json_path': 'buildprops.json', 06:51:25 INFO - 'config_files': ('talos/linux_config.py',), 06:51:25 INFO - 'default_actions': ('clobber', 06:51:25 INFO - 'read-buildbot-config', 06:51:25 INFO - 'download-and-extract', 06:51:25 INFO - 'populate-webroot', 06:51:25 INFO - 'create-virtualenv', 06:51:25 INFO - 'install', 06:51:25 INFO - 'run-tests'), 06:51:25 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 06:51:25 INFO - 'download_minidump_stackwalk': True, 06:51:25 INFO - 'download_symbols': 'ondemand', 06:51:25 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 06:51:25 INFO - 'tooltool.py': '/tools/tooltool.py', 06:51:25 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 06:51:25 INFO - '/tools/misc-python/virtualenv.py')}, 06:51:25 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 06:51:25 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 06:51:25 INFO - 'installer_path': 'installer.exe', 06:51:25 INFO - 'log_level': 'info', 06:51:25 INFO - 'log_name': 'talos', 06:51:25 INFO - 'log_to_console': True, 06:51:25 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 06:51:25 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 06:51:25 INFO - 'opt_config_files': (), 06:51:25 INFO - 'pip_index': False, 06:51:25 INFO - 'sps_profile': False, 06:51:25 INFO - 'sps_profile_interval': 0, 06:51:25 INFO - 'suite': 'dromaeojs', 06:51:25 INFO - 'system_bits': '64', 06:51:25 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 06:51:25 INFO - 'title': 'talos-linux64-ix-063', 06:51:25 INFO - 'tooltool_cache': '/builds/tooltool_cache', 06:51:25 INFO - 'use_talos_json': True, 06:51:25 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 06:51:25 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 06:51:25 INFO - 'work_dir': 'build'} 06:51:25 INFO - ##### 06:51:25 INFO - ##### Running clobber step. 06:51:25 INFO - ##### 06:51:25 INFO - Running pre-action listener: _resource_record_pre_action 06:51:25 INFO - Running main action method: clobber 06:51:25 INFO - rmtree: /builds/slave/test-pgo/build 06:51:25 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 06:51:25 INFO - Running post-action listener: _resource_record_post_action 06:51:25 INFO - ##### 06:51:25 INFO - ##### Running read-buildbot-config step. 06:51:25 INFO - ##### 06:51:25 INFO - Running pre-action listener: _resource_record_pre_action 06:51:25 INFO - Running main action method: read_buildbot_config 06:51:25 INFO - Using buildbot properties: 06:51:25 INFO - { 06:51:25 INFO - "properties": { 06:51:25 INFO - "buildnumber": 114, 06:51:25 INFO - "product": "firefox", 06:51:25 INFO - "script_repo_revision": "production", 06:51:25 INFO - "builddir": "b2g-inbound_ubuntu64_hw_test-dromaeojs", 06:51:25 INFO - "repository": "", 06:51:25 INFO - "buildername": "Ubuntu HW 12.04 x64 b2g-inbound pgo talos dromaeojs", 06:51:25 INFO - "buildid": "20151124053007", 06:51:25 INFO - "slavename": "talos-linux64-ix-063", 06:51:25 INFO - "pgo_build": "True", 06:51:25 INFO - "basedir": "/builds/slave/test-pgo", 06:51:25 INFO - "project": "", 06:51:25 INFO - "platform": "ubuntu64_hw", 06:51:25 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 06:51:25 INFO - "slavebuilddir": "test", 06:51:25 INFO - "scheduler": "tests-b2g-inbound-linux64-pgo-talos", 06:51:25 INFO - "branch": "b2g-inbound", 06:51:25 INFO - "repo_path": "integration/b2g-inbound", 06:51:25 INFO - "stage_platform": "linux64-pgo", 06:51:25 INFO - "builduid": "4e8d471afd544f5ba49a360c988e0e39", 06:51:25 INFO - "revision": "5a6b4eae6d8e2d67b0c50fe84ed30b4794bf25ea" 06:51:25 INFO - }, 06:51:25 INFO - "sourcestamp": { 06:51:25 INFO - "repository": "", 06:51:25 INFO - "hasPatch": false, 06:51:25 INFO - "project": "", 06:51:25 INFO - "branch": "b2g-inbound-linux64-pgo-talos", 06:51:25 INFO - "changes": [ 06:51:25 INFO - { 06:51:25 INFO - "category": null, 06:51:25 INFO - "files": [ 06:51:25 INFO - { 06:51:25 INFO - "url": null, 06:51:25 INFO - "name": "https://queue.taskcluster.net/v1/task/kTOGwxGGS5axXPoYVkQs6Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2" 06:51:25 INFO - } 06:51:25 INFO - ], 06:51:25 INFO - "repository": "", 06:51:25 INFO - "rev": "5a6b4eae6d8e2d67b0c50fe84ed30b4794bf25ea", 06:51:25 INFO - "who": "sendchange", 06:51:25 INFO - "when": 1448376590, 06:51:25 INFO - "number": 6700295, 06:51:25 INFO - "comments": "", 06:51:25 INFO - "project": "", 06:51:25 INFO - "at": "Tue 24 Nov 2015 06:49:50", 06:51:25 INFO - "branch": "b2g-inbound-linux64-pgo-talos", 06:51:25 INFO - "revlink": "", 06:51:25 INFO - "properties": [ 06:51:25 INFO - [ 06:51:25 INFO - "buildid", 06:51:25 INFO - "20151124053007", 06:51:25 INFO - "Change" 06:51:25 INFO - ], 06:51:25 INFO - [ 06:51:25 INFO - "builduid", 06:51:25 INFO - "4e8d471afd544f5ba49a360c988e0e39", 06:51:25 INFO - "Change" 06:51:25 INFO - ], 06:51:25 INFO - [ 06:51:25 INFO - "pgo_build", 06:51:25 INFO - "True", 06:51:25 INFO - "Change" 06:51:25 INFO - ] 06:51:25 INFO - ], 06:51:25 INFO - "revision": "5a6b4eae6d8e2d67b0c50fe84ed30b4794bf25ea" 06:51:25 INFO - } 06:51:25 INFO - ], 06:51:25 INFO - "revision": "5a6b4eae6d8e2d67b0c50fe84ed30b4794bf25ea" 06:51:25 INFO - } 06:51:25 INFO - } 06:51:25 INFO - Found installer url https://queue.taskcluster.net/v1/task/kTOGwxGGS5axXPoYVkQs6Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2. 06:51:25 INFO - Running post-action listener: _resource_record_post_action 06:51:25 INFO - ##### 06:51:25 INFO - ##### Running download-and-extract step. 06:51:25 INFO - ##### 06:51:25 INFO - Running pre-action listener: _resource_record_pre_action 06:51:25 INFO - Running main action method: download_and_extract 06:51:25 INFO - mkdir: /builds/slave/test-pgo/build/tests 06:51:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:51:25 INFO - https://queue.taskcluster.net/v1/task/kTOGwxGGS5axXPoYVkQs6Q/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 06:51:25 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/kTOGwxGGS5axXPoYVkQs6Q/artifacts/public/build/test_packages.json 06:51:25 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/kTOGwxGGS5axXPoYVkQs6Q/artifacts/public/build/test_packages.json 06:51:25 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/kTOGwxGGS5axXPoYVkQs6Q/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 06:51:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/kTOGwxGGS5axXPoYVkQs6Q/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 06:51:28 INFO - Downloaded 1302 bytes. 06:51:28 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 06:51:28 INFO - Using the following test package requirements: 06:51:28 INFO - {u'common': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 06:51:28 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 06:51:28 INFO - u'firefox-45.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 06:51:28 INFO - u'jittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 06:51:28 INFO - u'jsshell-linux-x86_64.zip'], 06:51:28 INFO - u'mochitest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 06:51:28 INFO - u'firefox-45.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 06:51:28 INFO - u'mozbase': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 06:51:28 INFO - u'reftest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 06:51:28 INFO - u'firefox-45.0a1.en-US.linux-x86_64.reftest.tests.zip'], 06:51:28 INFO - u'talos': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 06:51:28 INFO - u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'], 06:51:28 INFO - u'web-platform': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 06:51:28 INFO - u'firefox-45.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 06:51:28 INFO - u'webapprt': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 06:51:28 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 06:51:28 INFO - u'firefox-45.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 06:51:28 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 06:51:28 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')]} 06:51:28 INFO - https://queue.taskcluster.net/v1/task/kTOGwxGGS5axXPoYVkQs6Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 06:51:28 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/kTOGwxGGS5axXPoYVkQs6Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 06:51:28 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/kTOGwxGGS5axXPoYVkQs6Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 06:51:28 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/kTOGwxGGS5axXPoYVkQs6Q/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 06:51:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/kTOGwxGGS5axXPoYVkQs6Q/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 06:51:29 INFO - Downloaded 22525981 bytes. 06:51:29 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 06:51:29 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 06:51:29 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 06:51:30 INFO - Return code: 0 06:51:30 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 06:51:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:51:30 INFO - https://queue.taskcluster.net/v1/task/kTOGwxGGS5axXPoYVkQs6Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 06:51:30 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/kTOGwxGGS5axXPoYVkQs6Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 06:51:30 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/kTOGwxGGS5axXPoYVkQs6Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 06:51:30 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/kTOGwxGGS5axXPoYVkQs6Q/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 06:51:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/kTOGwxGGS5axXPoYVkQs6Q/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 06:51:32 INFO - Downloaded 22525981 bytes. 06:51:32 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test-pgo/build/tests 06:51:32 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 06:51:32 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 06:51:33 INFO - Return code: 0 06:51:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:51:33 INFO - https://queue.taskcluster.net/v1/task/kTOGwxGGS5axXPoYVkQs6Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 06:51:33 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/kTOGwxGGS5axXPoYVkQs6Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 06:51:33 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/kTOGwxGGS5axXPoYVkQs6Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 06:51:33 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/kTOGwxGGS5axXPoYVkQs6Q/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 06:51:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/kTOGwxGGS5axXPoYVkQs6Q/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 06:51:34 INFO - Downloaded 11130997 bytes. 06:51:34 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'] in /builds/slave/test-pgo/build/tests 06:51:34 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 06:51:34 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'] with output_timeout 1760 06:51:34 INFO - Return code: 0 06:51: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')]} 06:51:34 INFO - https://queue.taskcluster.net/v1/task/kTOGwxGGS5axXPoYVkQs6Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 06:51:34 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/kTOGwxGGS5axXPoYVkQs6Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 06:51:34 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/kTOGwxGGS5axXPoYVkQs6Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 06:51:34 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/kTOGwxGGS5axXPoYVkQs6Q/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 06:51:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/kTOGwxGGS5axXPoYVkQs6Q/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 06:51:35 INFO - Downloaded 57551948 bytes. 06:51:35 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/kTOGwxGGS5axXPoYVkQs6Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 06:51:35 INFO - mkdir: /builds/slave/test-pgo/properties 06:51:35 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 06:51:35 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 06:51:35 INFO - Contents: 06:51:35 INFO - build_url:https://queue.taskcluster.net/v1/task/kTOGwxGGS5axXPoYVkQs6Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 06:51:35 INFO - Running post-action listener: _resource_record_post_action 06:51:35 INFO - Running post-action listener: set_extra_try_arguments 06:51:35 INFO - ##### 06:51:35 INFO - ##### Running populate-webroot step. 06:51:35 INFO - ##### 06:51:35 INFO - Running pre-action listener: _resource_record_pre_action 06:51:35 INFO - Running main action method: populate_webroot 06:51:35 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 06:51:35 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 06:51:35 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 06:51:35 INFO - '../fennec_ids.txt'], 06:51:35 INFO - 'tests': ['tcheck2']}, 06:51:35 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 06:51:35 INFO - '--tppagecycles', 06:51:35 INFO - '7'], 06:51:35 INFO - 'tests': ['tsvgm']}}, 06:51:35 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 06:51:35 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 06:51:35 INFO - 'tests': ['tresize', 'tcanvasmark']}, 06:51:35 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 06:51:35 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 06:51:35 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 06:51:35 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:51:35 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:51:35 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:51:35 INFO - 'talos_options': ['--e10s'], 06:51:35 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:51:35 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:51:35 INFO - 'tests': ['damp', 'tps']}, 06:51:35 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:51:35 INFO - 'talos_options': ['--e10s'], 06:51:35 INFO - 'tests': ['damp', 'tps']}, 06:51:35 INFO - 'g3': {'tests': ['dromaeo_dom']}, 06:51:35 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 06:51:35 INFO - 'other': {'tests': ['a11yr', 06:51:35 INFO - 'ts_paint', 06:51:35 INFO - 'tpaint', 06:51:35 INFO - 'sessionrestore', 06:51:35 INFO - 'sessionrestore_no_auto_restore']}, 06:51:35 INFO - 'other-e10s': {'talos_options': ['--e10s'], 06:51:35 INFO - 'tests': ['a11yr', 06:51:35 INFO - 'ts_paint', 06:51:35 INFO - 'tpaint', 06:51:35 INFO - 'sessionrestore', 06:51:35 INFO - 'sessionrestore_no_auto_restore']}, 06:51:35 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 06:51:35 INFO - 'tests': ['a11yr', 06:51:35 INFO - 'ts_paint', 06:51:35 INFO - 'tpaint', 06:51:35 INFO - 'sessionrestore', 06:51:35 INFO - 'sessionrestore_no_auto_restore']}, 06:51:35 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 06:51:35 INFO - 'tests': ['a11yr', 06:51:35 INFO - 'ts_paint', 06:51:35 INFO - 'tpaint', 06:51:35 INFO - 'sessionrestore', 06:51:35 INFO - 'sessionrestore_no_auto_restore']}, 06:51:35 INFO - 'other_l64': {'tests': ['a11yr', 06:51:35 INFO - 'ts_paint', 06:51:35 INFO - 'tpaint', 06:51:35 INFO - 'sessionrestore', 06:51:35 INFO - 'sessionrestore_no_auto_restore']}, 06:51:35 INFO - 'other_nol64': {'tests': ['a11yr', 06:51:35 INFO - 'ts_paint', 06:51:35 INFO - 'tpaint', 06:51:35 INFO - 'sessionrestore', 06:51:35 INFO - 'sessionrestore_no_auto_restore']}, 06:51:35 INFO - 'svgr': {'tests': ['tsvgx', 06:51:35 INFO - 'tsvgr_opacity', 06:51:35 INFO - 'tart', 06:51:35 INFO - 'tscrollx', 06:51:35 INFO - 'cart']}, 06:51:35 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 06:51:35 INFO - 'tests': ['tsvgx', 06:51:35 INFO - 'tsvgr_opacity', 06:51:35 INFO - 'tart', 06:51:35 INFO - 'tscrollx', 06:51:35 INFO - 'cart']}, 06:51:35 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:51:35 INFO - 'tests': ['tp5o']}, 06:51:35 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:51:35 INFO - 'talos_options': ['--e10s'], 06:51:35 INFO - 'tests': ['tp5o']}, 06:51:35 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:51:35 INFO - 'talos_options': ['--xperf_path', 06:51:35 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:51:35 INFO - 'tests': ['tp5n']}, 06:51:35 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:51:35 INFO - 'talos_options': ['--e10s', 06:51:35 INFO - '--xperf_path', 06:51:35 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:51:35 INFO - 'tests': ['tp5n']}}, 06:51:35 INFO - 'talos.zip': {'path': '', 06:51:35 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 06:51:35 INFO - Running post-action listener: _resource_record_post_action 06:51:35 INFO - ##### 06:51:35 INFO - ##### Running create-virtualenv step. 06:51:35 INFO - ##### 06:51:35 INFO - Running pre-action listener: _resource_record_pre_action 06:51:35 INFO - Running main action method: create_virtualenv 06:51:35 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 06:51:35 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 06:51:35 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 06:51:36 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 06:51:36 INFO - Using real prefix '/usr' 06:51:36 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 06:51:36 INFO - Installing distribute.............................................................................................................................................................................................done. 06:51:38 INFO - Installing pip.................done. 06:51:38 INFO - Return code: 0 06:51:38 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 06:51:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:51:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:51:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:51:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:51:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:51:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:51:38 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8f16ec3c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25486c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25fa7c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x263ed70>, '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 0x263fb20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x263ffb0>, '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': 'edca6ca23558fe0608d91a4e00000196-1448376508.945868-1650807499', '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 06:51:38 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test-pgo/build 06:51:38 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 06:51:38 INFO - Using env: {'DISPLAY': ':0', 06:51:38 INFO - 'HOME': '/home/cltbld', 06:51:38 INFO - 'LANG': 'en_US.UTF-8', 06:51:38 INFO - 'LANGUAGE': 'en_US:en', 06:51:38 INFO - 'LOGNAME': 'cltbld', 06:51:38 INFO - 'MAIL': '/var/mail/cltbld', 06:51:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:51:38 INFO - 'MOZ_NO_REMOTE': '1', 06:51:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:51:38 INFO - 'NO_EM_RESTART': '1', 06:51:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:51:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 06:51:38 INFO - 'PWD': '/builds/slave/test-pgo', 06:51:38 INFO - 'SHELL': '/bin/bash', 06:51:38 INFO - 'SHLVL': '1', 06:51:38 INFO - 'TERM': 'linux', 06:51:38 INFO - 'TMOUT': '86400', 06:51:38 INFO - 'USER': 'cltbld', 06:51:38 INFO - 'XDG_SESSION_COOKIE': 'edca6ca23558fe0608d91a4e00000196-1448376508.945868-1650807499', 06:51:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:51:38 INFO - '_': '/tools/buildbot/bin/python'} 06:51:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:51:38 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 06:51:38 INFO - Cleaning up... 06:51:38 INFO - Return code: 0 06:51:38 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 06:51:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:51:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:51:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:51:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:51:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:51:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:51:38 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f8f16ec3c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25486c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25fa7c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x263ed70>, '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 0x263fb20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x263ffb0>, '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': 'edca6ca23558fe0608d91a4e00000196-1448376508.945868-1650807499', '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 06:51:38 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test-pgo/build 06:51:38 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 06:51:38 INFO - Using env: {'DISPLAY': ':0', 06:51:38 INFO - 'HOME': '/home/cltbld', 06:51:38 INFO - 'LANG': 'en_US.UTF-8', 06:51:38 INFO - 'LANGUAGE': 'en_US:en', 06:51:38 INFO - 'LOGNAME': 'cltbld', 06:51:38 INFO - 'MAIL': '/var/mail/cltbld', 06:51:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:51:38 INFO - 'MOZ_NO_REMOTE': '1', 06:51:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:51:38 INFO - 'NO_EM_RESTART': '1', 06:51:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:51:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 06:51:38 INFO - 'PWD': '/builds/slave/test-pgo', 06:51:38 INFO - 'SHELL': '/bin/bash', 06:51:38 INFO - 'SHLVL': '1', 06:51:38 INFO - 'TERM': 'linux', 06:51:38 INFO - 'TMOUT': '86400', 06:51:38 INFO - 'USER': 'cltbld', 06:51:38 INFO - 'XDG_SESSION_COOKIE': 'edca6ca23558fe0608d91a4e00000196-1448376508.945868-1650807499', 06:51:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:51:38 INFO - '_': '/tools/buildbot/bin/python'} 06:51:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:51:38 INFO - Downloading/unpacking psutil>=0.7.1 06:51:38 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 06:51:38 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 06:51:38 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 06:51:38 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 06:51:38 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 06:51:38 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 06:51:40 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 06:51:40 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 06:51:40 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 06:51:40 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:51:40 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:51:40 INFO - Installing collected packages: psutil 06:51:40 INFO - Running setup.py install for psutil 06:51:40 INFO - building 'psutil._psutil_linux' extension 06:51:40 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 06:51:41 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 06:51:41 INFO - building 'psutil._psutil_posix' extension 06:51:41 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 06:51:41 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 06:51:41 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:51:41 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:51:41 INFO - Successfully installed psutil 06:51:41 INFO - Cleaning up... 06:51:41 INFO - Return code: 0 06:51:41 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 06:51: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')]} 06:51:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:51:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:51: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')]} 06:51:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:51:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:51:41 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8f16ec3c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25486c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25fa7c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x263ed70>, '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 0x263fb20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x263ffb0>, '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': 'edca6ca23558fe0608d91a4e00000196-1448376508.945868-1650807499', '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 06:51:41 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test-pgo/build 06:51:41 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 06:51:41 INFO - Using env: {'DISPLAY': ':0', 06:51:41 INFO - 'HOME': '/home/cltbld', 06:51:41 INFO - 'LANG': 'en_US.UTF-8', 06:51:41 INFO - 'LANGUAGE': 'en_US:en', 06:51:41 INFO - 'LOGNAME': 'cltbld', 06:51:41 INFO - 'MAIL': '/var/mail/cltbld', 06:51:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:51:41 INFO - 'MOZ_NO_REMOTE': '1', 06:51:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:51:41 INFO - 'NO_EM_RESTART': '1', 06:51:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:51:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 06:51:41 INFO - 'PWD': '/builds/slave/test-pgo', 06:51:41 INFO - 'SHELL': '/bin/bash', 06:51:41 INFO - 'SHLVL': '1', 06:51:41 INFO - 'TERM': 'linux', 06:51:41 INFO - 'TMOUT': '86400', 06:51:41 INFO - 'USER': 'cltbld', 06:51:41 INFO - 'XDG_SESSION_COOKIE': 'edca6ca23558fe0608d91a4e00000196-1448376508.945868-1650807499', 06:51:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:51:41 INFO - '_': '/tools/buildbot/bin/python'} 06:51:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:51:41 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 06:51:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:51:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:51:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:51:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:51:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:51:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:51:43 INFO - Downloading mozsystemmonitor-0.0.tar.gz 06:51:43 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 06:51:43 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 06:51:43 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 06:51:43 INFO - Installing collected packages: mozsystemmonitor 06:51:43 INFO - Running setup.py install for mozsystemmonitor 06:51:43 INFO - Successfully installed mozsystemmonitor 06:51:43 INFO - Cleaning up... 06:51:43 INFO - Return code: 0 06:51:43 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 06:51:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:51:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:51:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:51:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:51:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:51:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:51:43 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8f16ec3c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25486c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25fa7c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x263ed70>, '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 0x263fb20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x263ffb0>, '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': 'edca6ca23558fe0608d91a4e00000196-1448376508.945868-1650807499', '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 06:51:43 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test-pgo/build 06:51:43 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 06:51:43 INFO - Using env: {'DISPLAY': ':0', 06:51:43 INFO - 'HOME': '/home/cltbld', 06:51:43 INFO - 'LANG': 'en_US.UTF-8', 06:51:43 INFO - 'LANGUAGE': 'en_US:en', 06:51:43 INFO - 'LOGNAME': 'cltbld', 06:51:43 INFO - 'MAIL': '/var/mail/cltbld', 06:51:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:51:43 INFO - 'MOZ_NO_REMOTE': '1', 06:51:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:51:43 INFO - 'NO_EM_RESTART': '1', 06:51:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:51:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 06:51:43 INFO - 'PWD': '/builds/slave/test-pgo', 06:51:43 INFO - 'SHELL': '/bin/bash', 06:51:43 INFO - 'SHLVL': '1', 06:51:43 INFO - 'TERM': 'linux', 06:51:43 INFO - 'TMOUT': '86400', 06:51:43 INFO - 'USER': 'cltbld', 06:51:43 INFO - 'XDG_SESSION_COOKIE': 'edca6ca23558fe0608d91a4e00000196-1448376508.945868-1650807499', 06:51:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:51:43 INFO - '_': '/tools/buildbot/bin/python'} 06:51:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:51:43 INFO - Downloading/unpacking blobuploader==1.2.4 06:51:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:51:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:51:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:51:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:51:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:51:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:51:45 INFO - Downloading blobuploader-1.2.4.tar.gz 06:51:45 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 06:51:45 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 06:51:45 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 06:51:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:51:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:51:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:51:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:51:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:51:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:51:45 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 06:51:45 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 06:51:45 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 06:51:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:51:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:51:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:51:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:51:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:51:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:51:45 INFO - Downloading docopt-0.6.1.tar.gz 06:51:45 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 06:51:45 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 06:51:45 INFO - Installing collected packages: blobuploader, requests, docopt 06:51:45 INFO - Running setup.py install for blobuploader 06:51:46 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 06:51:46 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 06:51:46 INFO - Running setup.py install for requests 06:51:46 INFO - Running setup.py install for docopt 06:51:46 INFO - Successfully installed blobuploader requests docopt 06:51:46 INFO - Cleaning up... 06:51:46 INFO - Return code: 0 06:51:46 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 06:51: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')]} 06:51:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:51:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:51: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')]} 06:51:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:51:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:51:46 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8f16ec3c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25486c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25fa7c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x263ed70>, '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 0x263fb20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x263ffb0>, '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': 'edca6ca23558fe0608d91a4e00000196-1448376508.945868-1650807499', '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 06:51:46 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/config 06:51:46 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --no-deps --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 06:51:46 INFO - Using env: {'DISPLAY': ':0', 06:51:46 INFO - 'HOME': '/home/cltbld', 06:51:46 INFO - 'LANG': 'en_US.UTF-8', 06:51:46 INFO - 'LANGUAGE': 'en_US:en', 06:51:46 INFO - 'LOGNAME': 'cltbld', 06:51:46 INFO - 'MAIL': '/var/mail/cltbld', 06:51:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:51:46 INFO - 'MOZ_NO_REMOTE': '1', 06:51:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:51:46 INFO - 'NO_EM_RESTART': '1', 06:51:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:51:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 06:51:46 INFO - 'PWD': '/builds/slave/test-pgo', 06:51:46 INFO - 'SHELL': '/bin/bash', 06:51:46 INFO - 'SHLVL': '1', 06:51:46 INFO - 'TERM': 'linux', 06:51:46 INFO - 'TMOUT': '86400', 06:51:46 INFO - 'USER': 'cltbld', 06:51:46 INFO - 'XDG_SESSION_COOKIE': 'edca6ca23558fe0608d91a4e00000196-1448376508.945868-1650807499', 06:51:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:51:46 INFO - '_': '/tools/buildbot/bin/python'} 06:51:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:51:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 06:51:46 INFO - Running setup.py (path:/tmp/pip-Xc7PCR-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 06:51:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 06:51:46 INFO - Running setup.py (path:/tmp/pip-hx7u0A-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 06:51:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 06:51:46 INFO - Running setup.py (path:/tmp/pip-GxNuai-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 06:51:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 06:51:47 INFO - Running setup.py (path:/tmp/pip-hMvK80-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 06:51:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 06:51:47 INFO - Running setup.py (path:/tmp/pip-Tnr4Ih-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 06:51:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 06:51:47 INFO - Running setup.py (path:/tmp/pip-6f79cj-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 06:51:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 06:51:47 INFO - Running setup.py (path:/tmp/pip-_lm3s_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 06:51:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 06:51:47 INFO - Running setup.py (path:/tmp/pip-0UAgEp-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 06:51:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 06:51:47 INFO - Running setup.py (path:/tmp/pip-KzN0O5-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 06:51:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 06:51:47 INFO - Running setup.py (path:/tmp/pip-_8VWgy-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 06:51:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 06:51:47 INFO - Running setup.py (path:/tmp/pip-KOTEN_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 06:51:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 06:51:47 INFO - Running setup.py (path:/tmp/pip-hPY6dM-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 06:51:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 06:51:47 INFO - Running setup.py (path:/tmp/pip-YCmtCs-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 06:51:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 06:51:47 INFO - Running setup.py (path:/tmp/pip-RVhFF9-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 06:51:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 06:51:47 INFO - Running setup.py (path:/tmp/pip-t0a3l9-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 06:51:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 06:51:47 INFO - Running setup.py (path:/tmp/pip-Vds_NY-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 06:51:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 06:51:47 INFO - Running setup.py (path:/tmp/pip-CWwdkg-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 06:51:47 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 06:51:47 INFO - Running setup.py install for manifestparser 06:51:48 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 06:51:48 INFO - Running setup.py install for mozcrash 06:51:48 INFO - Running setup.py install for mozdebug 06:51:48 INFO - Running setup.py install for mozdevice 06:51:48 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 06:51:48 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 06:51:48 INFO - Running setup.py install for mozfile 06:51:48 INFO - Running setup.py install for mozhttpd 06:51:48 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 06:51:48 INFO - Running setup.py install for mozinfo 06:51:48 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 06:51:48 INFO - Running setup.py install for mozInstall 06:51:48 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 06:51:48 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 06:51:48 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 06:51:48 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 06:51:48 INFO - Running setup.py install for mozleak 06:51:48 INFO - Running setup.py install for mozlog 06:51:49 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 06:51:49 INFO - Running setup.py install for moznetwork 06:51:49 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 06:51:49 INFO - Running setup.py install for mozprocess 06:51:49 INFO - Running setup.py install for mozprofile 06:51:49 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 06:51:49 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 06:51:49 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 06:51:49 INFO - Running setup.py install for mozrunner 06:51:49 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 06:51:49 INFO - Running setup.py install for mozscreenshot 06:51:49 INFO - Running setup.py install for moztest 06:51:49 INFO - Running setup.py install for mozversion 06:51:49 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 06:51:49 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 06:51:49 INFO - Cleaning up... 06:51:49 INFO - Return code: 0 06:51:49 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 06:51: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')]} 06:51:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:51:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:51: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')]} 06:51:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:51:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:51: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', '-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 0x7f8f16ec3c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25486c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25fa7c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x263ed70>, '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 0x263fb20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x263ffb0>, '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': 'edca6ca23558fe0608d91a4e00000196-1448376508.945868-1650807499', '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 06:51:49 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 06:51:49 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 06:51:49 INFO - Using env: {'DISPLAY': ':0', 06:51:49 INFO - 'HOME': '/home/cltbld', 06:51:49 INFO - 'LANG': 'en_US.UTF-8', 06:51:49 INFO - 'LANGUAGE': 'en_US:en', 06:51:49 INFO - 'LOGNAME': 'cltbld', 06:51:49 INFO - 'MAIL': '/var/mail/cltbld', 06:51:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:51:49 INFO - 'MOZ_NO_REMOTE': '1', 06:51:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:51:49 INFO - 'NO_EM_RESTART': '1', 06:51:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:51:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 06:51:49 INFO - 'PWD': '/builds/slave/test-pgo', 06:51:49 INFO - 'SHELL': '/bin/bash', 06:51:49 INFO - 'SHLVL': '1', 06:51:49 INFO - 'TERM': 'linux', 06:51:49 INFO - 'TMOUT': '86400', 06:51:49 INFO - 'USER': 'cltbld', 06:51:49 INFO - 'XDG_SESSION_COOKIE': 'edca6ca23558fe0608d91a4e00000196-1448376508.945868-1650807499', 06:51:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:51:49 INFO - '_': '/tools/buildbot/bin/python'} 06:51:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:51:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 06:51:50 INFO - Running setup.py (path:/tmp/pip-gErBJ6-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 06:51:50 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 1)) 06:51:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 06:51:50 INFO - Running setup.py (path:/tmp/pip-629Y9U-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 06:51:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.16 from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 06:51:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 06:51:50 INFO - Running setup.py (path:/tmp/pip-InJAJn-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 06:51:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 3)) 06:51:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 06:51:50 INFO - Running setup.py (path:/tmp/pip-C5xwDz-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 06:51:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.47 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 06:51:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 06:51:50 INFO - Running setup.py (path:/tmp/pip-d6X5HU-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 06:51:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 5)) 06:51:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 06:51:50 INFO - Running setup.py (path:/tmp/pip-zpfHSO-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 06:51:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 6)) 06:51:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 06:51:50 INFO - Running setup.py (path:/tmp/pip-hvblPa-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 06:51:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 7)) 06:51:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 06:51:50 INFO - Running setup.py (path:/tmp/pip-kcSoFC-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 06:51:50 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)) 06:51:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 06:51:50 INFO - Running setup.py (path:/tmp/pip-oPWCNJ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 06:51:50 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)) 06:51:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 06:51:50 INFO - Running setup.py (path:/tmp/pip-Xmo7sb-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 06:51:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 06:51:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 06:51:50 INFO - Running setup.py (path:/tmp/pip-IVcuEG-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 06:51:50 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)) 06:51:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 06:51:50 INFO - Running setup.py (path:/tmp/pip-FWxW2m-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 06:51:50 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)) 06:51:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 06:51:50 INFO - Running setup.py (path:/tmp/pip-KtLyLZ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 06:51:50 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)) 06:51:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 06:51:50 INFO - Running setup.py (path:/tmp/pip-0o169w-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 06:51:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 14)) 06:51:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 06:51:51 INFO - Running setup.py (path:/tmp/pip-4VSuTK-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 06:51:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 15)) 06:51:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 06:51:51 INFO - Running setup.py (path:/tmp/pip-XusvlB-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 06:51:51 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test-pgo/build/tests/mozbase/moztest in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 16)) 06:51:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 06:51:51 INFO - Running setup.py (path:/tmp/pip-XPRIkT-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 06:51:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 17)) 06:51:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 06:51:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 06:51:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 3)) 06:51:51 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 06:51:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 06:51:51 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 06:51: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 06:51: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 06:51: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 06:51: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 06:51: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 06:51: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 06:51:52 INFO - Downloading blessings-1.5.1.tar.gz 06:51:52 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 06:51:52 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 06:51:53 INFO - Installing collected packages: blessings 06:51:53 INFO - Running setup.py install for blessings 06:51:53 INFO - Successfully installed blessings 06:51:53 INFO - Cleaning up... 06:51:53 INFO - Return code: 0 06:51:53 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 06:51:53 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 06:51:53 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 06:51:53 INFO - Reading from file tmpfile_stdout 06:51:53 INFO - Current package versions: 06:51:53 INFO - argparse == 1.2.1 06:51:53 INFO - blessings == 1.5.1 06:51:53 INFO - blobuploader == 1.2.4 06:51:53 INFO - docopt == 0.6.1 06:51:53 INFO - manifestparser == 1.1 06:51:53 INFO - mozInstall == 1.12 06:51:53 INFO - mozcrash == 0.16 06:51:53 INFO - mozdebug == 0.1 06:51:53 INFO - mozdevice == 0.47 06:51:53 INFO - mozfile == 1.2 06:51:53 INFO - mozhttpd == 0.7 06:51:53 INFO - mozinfo == 0.9 06:51:53 INFO - mozleak == 0.1 06:51:53 INFO - mozlog == 3.1 06:51:53 INFO - moznetwork == 0.27 06:51:53 INFO - mozprocess == 0.22 06:51:53 INFO - mozprofile == 0.27 06:51:53 INFO - mozrunner == 6.11 06:51:53 INFO - mozscreenshot == 0.1 06:51:53 INFO - mozsystemmonitor == 0.0 06:51:53 INFO - moztest == 0.7 06:51:53 INFO - mozversion == 1.4 06:51:53 INFO - psutil == 3.1.1 06:51:53 INFO - requests == 1.2.3 06:51:53 INFO - wsgiref == 0.1.2 06:51:53 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 06:51:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:51:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:51:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:51:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:51:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:51:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:51:53 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8f16ec3c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25486c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25fa7c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x263ed70>, '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 0x263fb20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x263ffb0>, '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': 'edca6ca23558fe0608d91a4e00000196-1448376508.945868-1650807499', '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 06:51:53 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/talos 06:51:53 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 -r /builds/slave/test-pgo/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 06:51:53 INFO - Using env: {'DISPLAY': ':0', 06:51:53 INFO - 'HOME': '/home/cltbld', 06:51:53 INFO - 'LANG': 'en_US.UTF-8', 06:51:53 INFO - 'LANGUAGE': 'en_US:en', 06:51:53 INFO - 'LOGNAME': 'cltbld', 06:51:53 INFO - 'MAIL': '/var/mail/cltbld', 06:51:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:51:53 INFO - 'MOZ_NO_REMOTE': '1', 06:51:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:51:53 INFO - 'NO_EM_RESTART': '1', 06:51:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:51:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 06:51:53 INFO - 'PWD': '/builds/slave/test-pgo', 06:51:53 INFO - 'SHELL': '/bin/bash', 06:51:53 INFO - 'SHLVL': '1', 06:51:53 INFO - 'TERM': 'linux', 06:51:53 INFO - 'TMOUT': '86400', 06:51:53 INFO - 'USER': 'cltbld', 06:51:53 INFO - 'XDG_SESSION_COOKIE': 'edca6ca23558fe0608d91a4e00000196-1448376508.945868-1650807499', 06:51:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:51:53 INFO - '_': '/tools/buildbot/bin/python'} 06:51:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:51:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 06:51:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 2)) 06:51:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 3)) 06:51:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 4)) 06:51:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 5)) 06:51:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 6)) 06:51:53 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)) 06:51:53 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)) 06:51:53 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)) 06:51:53 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)) 06:51:53 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)) 06:51:53 INFO - Cleaning up... 06:51:53 INFO - Return code: 0 06:51:53 INFO - Running post-action listener: _resource_record_post_action 06:51:53 INFO - Running post-action listener: _start_resource_monitoring 06:51:53 INFO - Starting resource monitoring. 06:51:53 INFO - ##### 06:51:53 INFO - ##### Running install step. 06:51:53 INFO - ##### 06:51:53 INFO - Running pre-action listener: _resource_record_pre_action 06:51:53 INFO - Running main action method: install 06:51:53 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 06:51:53 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 06:51:53 INFO - Reading from file tmpfile_stdout 06:51:53 INFO - Detecting whether we're running mozinstall >=1.0... 06:51:53 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 06:51:53 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 06:51:53 INFO - Reading from file tmpfile_stdout 06:51:53 INFO - Output received: 06:51:53 INFO - Usage: mozinstall [options] installer 06:51:53 INFO - Options: 06:51:53 INFO - -h, --help show this help message and exit 06:51:53 INFO - -d DEST, --destination=DEST 06:51:53 INFO - Directory to install application into. [default: 06:51:53 INFO - "/builds/slave/test-pgo"] 06:51:53 INFO - --app=APP Application being installed. [default: firefox] 06:51:53 INFO - mkdir: /builds/slave/test-pgo/build/application 06:51:53 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'] 06:51:53 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 06:52:08 INFO - Reading from file tmpfile_stdout 06:52:08 INFO - Output received: 06:52:08 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 06:52:08 INFO - Running post-action listener: _resource_record_post_action 06:52:08 INFO - ##### 06:52:08 INFO - ##### Running run-tests step. 06:52:08 INFO - ##### 06:52:08 INFO - Running pre-action listener: _resource_record_pre_action 06:52:08 INFO - Running main action method: run_tests 06:52:08 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 06:52:08 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 06:52:08 INFO - Python 2.7.3 06:52:08 INFO - Return code: 0 06:52:08 INFO - grabbing minidump binary from tooltool 06:52:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:52:08 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x263ed70>, '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 0x263fb20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x263ffb0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 06:52:08 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test-pgo/build 06:52:08 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 06:52:08 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 06:52:08 INFO - Return code: 0 06:52:08 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 06:52:08 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 06:52:08 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 06:52:08 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 06:52:08 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 06:52:08 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'B2G-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/kTOGwxGGS5axXPoYVkQs6Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-063', '--webServer', 'localhost'] in /builds/slave/test-pgo/build 06:52:08 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --debug --branchName B2G-Inbound --suite dromaeojs --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/kTOGwxGGS5axXPoYVkQs6Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-063 --webServer localhost 06:52:08 INFO - Using env: {'DISPLAY': ':0', 06:52:08 INFO - 'HOME': '/home/cltbld', 06:52:08 INFO - 'LANG': 'en_US.UTF-8', 06:52:08 INFO - 'LANGUAGE': 'en_US:en', 06:52:08 INFO - 'LOGNAME': 'cltbld', 06:52:08 INFO - 'MAIL': '/var/mail/cltbld', 06:52:08 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 06:52:08 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 06:52:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:52:08 INFO - 'MOZ_NO_REMOTE': '1', 06:52:08 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 06:52:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:52:08 INFO - 'NO_EM_RESTART': '1', 06:52:08 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:52:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 06:52:08 INFO - 'PWD': '/builds/slave/test-pgo', 06:52:08 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 06:52:08 INFO - 'SHELL': '/bin/bash', 06:52:08 INFO - 'SHLVL': '1', 06:52:08 INFO - 'TERM': 'linux', 06:52:08 INFO - 'TMOUT': '86400', 06:52:08 INFO - 'USER': 'cltbld', 06:52:08 INFO - 'XDG_SESSION_COOKIE': 'edca6ca23558fe0608d91a4e00000196-1448376508.945868-1650807499', 06:52:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:52:08 INFO - '_': '/tools/buildbot/bin/python'} 06:52:08 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'B2G-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/kTOGwxGGS5axXPoYVkQs6Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-063', '--webServer', 'localhost'] with output_timeout 3600 06:52:08 INFO - mozversion INFO | application_buildid: 20151124053007 06:52:08 INFO - mozversion INFO | application_changeset: 5a6b4eae6d8e2d67b0c50fe84ed30b4794bf25ea 06:52:08 INFO - mozversion INFO | application_display_name: Nightly 06:52:08 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 06:52:08 INFO - mozversion INFO | application_name: Firefox 06:52:08 INFO - mozversion INFO | application_remotingname: firefox 06:52:08 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/b2g-inbound 06:52:08 INFO - mozversion INFO | application_vendor: Mozilla 06:52:08 INFO - mozversion INFO | application_version: 45.0a1 06:52:08 INFO - mozversion INFO | platform_buildid: 20151124053007 06:52:08 INFO - mozversion INFO | platform_changeset: 5a6b4eae6d8e2d67b0c50fe84ed30b4794bf25ea 06:52:08 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/b2g-inbound 06:52:08 INFO - mozversion INFO | platform_version: 45.0a1 06:52:08 INFO - 2015-11-24 06:52:08,700 DEBUG : using testdate: 1448376728 06:52:08 INFO - 2015-11-24 06:52:08,700 DEBUG : actual date: 1448376728 06:52:08 INFO - 2015-11-24 06:52:08,710 INFO : starting webserver on 'localhost:43074' 06:52:08 INFO - 2015-11-24 06:52:08,711 INFO : Starting test suite talos-linux64-ix-063 06:52:08 INFO - 2015-11-24 06:52:08,711 INFO : Starting test dromaeo_css 06:52:08 INFO - 2015-11-24 06:52:08,711 DEBUG : operating with platform_type : linux_ 06:52:08 INFO - 2015-11-24 06:52:08,712 INFO : Initialising browser for dromaeo_css test... 06:52:08 INFO - 2015-11-24 06:52:08,728 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpDG7DVz/profile http://localhost:43074/getInfo.html 06:52:12 INFO - 2015-11-24 06:52:12,648 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 06:52:12 INFO - 2015-11-24 06:52:12,649 DEBUG : BROWSER_OUTPUT: colorDepth:24 06:52:12 INFO - 2015-11-24 06:52:12,649 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 06:52:12 INFO - 2015-11-24 06:52:12,649 DEBUG : BROWSER_OUTPUT: __metrics 06:52:12 INFO - 2015-11-24 06:52:12,793 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 06:52:13 INFO - 2015-11-24 06:52:13,948 INFO : Browser initialized. 06:52:13 INFO - 2015-11-24 06:52:13,948 INFO : Running cycle 1/1 for dromaeo_css test... 06:52:13 INFO - 2015-11-24 06:52:13,949 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpDG7DVz/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 06:52:25 INFO - 2015-11-24 06:52:25,649 DEBUG : BROWSER_OUTPUT: RSS: Main: 141922304 06:52:25 INFO - 2015-11-24 06:52:25,649 DEBUG : BROWSER_OUTPUT: 06:53:17 INFO - 2015-11-24 06:53:17,330 DEBUG : BROWSER_OUTPUT: 1448376797325 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] 06:55:26 INFO - 2015-11-24 06:55:26,066 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43074/tests/dromaeo/cssquery-dojo.html (next: http://localhost:43074/tests/dromaeo/cssquery-ext.html) 06:55:27 INFO - 2015-11-24 06:55:27,256 DEBUG : BROWSER_OUTPUT: RSS: Main: 264220672 06:55:27 INFO - 2015-11-24 06:55:27,256 DEBUG : BROWSER_OUTPUT: 06:58:29 INFO - 2015-11-24 06:58:29,533 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43074/tests/dromaeo/cssquery-ext.html (next: http://localhost:43074/tests/dromaeo/cssquery-jquery.html) 06:58:30 INFO - 2015-11-24 06:58:30,099 DEBUG : BROWSER_OUTPUT: RSS: Main: 221831168 06:58:30 INFO - 2015-11-24 06:58:30,099 DEBUG : BROWSER_OUTPUT: 07:01:32 INFO - 2015-11-24 07:01:32,018 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43074/tests/dromaeo/cssquery-jquery.html (next: http://localhost:43074/tests/dromaeo/cssquery-mootools.html) 07:01:32 INFO - 2015-11-24 07:01:32,585 DEBUG : BROWSER_OUTPUT: RSS: Main: 218812416 07:01:32 INFO - 2015-11-24 07:01:32,585 DEBUG : BROWSER_OUTPUT: 07:04:34 INFO - 2015-11-24 07:04:34,381 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43074/tests/dromaeo/cssquery-mootools.html (next: http://localhost:43074/tests/dromaeo/cssquery-prototype.html) 07:04:34 INFO - 2015-11-24 07:04:34,962 DEBUG : BROWSER_OUTPUT: RSS: Main: 202723328 07:04:34 INFO - 2015-11-24 07:04:34,962 DEBUG : BROWSER_OUTPUT: 07:07:37 INFO - 2015-11-24 07:07:37,294 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43074/tests/dromaeo/cssquery-prototype.html (next: http://localhost:43074/tests/dromaeo/cssquery-yui.html) 07:07:37 INFO - 2015-11-24 07:07:37,880 DEBUG : BROWSER_OUTPUT: RSS: Main: 205185024 07:07:37 INFO - 2015-11-24 07:07:37,880 DEBUG : BROWSER_OUTPUT: 07:10:40 INFO - 2015-11-24 07:10:40,393 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43074/tests/dromaeo/cssquery-yui.html (next: http://localhost:43074/tests/dromaeo/cssquery-dojo.html) 07:10:40 INFO - 2015-11-24 07:10:40,643 DEBUG : BROWSER_OUTPUT: RSS: Main: 263081984 07:10:40 INFO - 2015-11-24 07:10:40,643 DEBUG : BROWSER_OUTPUT: 07:10:40 INFO - 2015-11-24 07:10:40,644 DEBUG : BROWSER_OUTPUT: __start_tp_report 07:10:40 INFO - 2015-11-24 07:10:40,645 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 07:10:40 INFO - 2015-11-24 07:10:40,645 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 07:10:40 INFO - 2015-11-24 07:10:40,645 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 07:10:40 INFO - 2015-11-24 07:10:40,646 DEBUG : BROWSER_OUTPUT: |0;dojo.html;3113.5018397056474;3114.6106736657916;3199.712025917667;3210.7270881975032;3223.7743357964937;5247.658902171356;5333.040052790496;5357.491038351351;5429.4570542945685;5437.265969094176;5300.204969254613;5397.082495975684;5398.217258497515;5523.696196709179;5525.585581081415;4970.627202959774;4995.725235112068;5029.321041659366;5042.520960508746;5098.082345177866;5019.071471777715;5095;5109.386873575176;5121.257417674435;5140.306058682087;4845.466998630148;4906.975465122688;4931.556159945622;5052.14113600687;5113.233015047754;4901.50984901507;4926.679765815211;4943.9258411123865;5013.273075404046;5026.5727413169925;4953.5541801237705;4984.102861484931;5005.249212618136;5007.92488112675;5049.091163590552;5132.435432102466;5230.293910322096;5282.445343238982;5316.627836051478;5325.680459172462;5798.507126894219;5803.071508558653;5891.116332550109;5907.9704601476715;5925.229720136398;5836.766529338822;5989.460948514655;5989.55078369124;6052.334243233285;6052.4552790248645;5276.287701160371;5563.082091454905;5573.9163912540935;5575.0522411190195;5576.804811831566;5840.912386314124;5926.081457374114;5933.317668468095;5936.614120082181;5945.64326140433;5799.507041901401;5813.418658134153;5849.473547380671;5851.6781577012825;5859.794907178313;5697.088465845445;5847.502962248256;5944.048952167633;5957;5958.76164953397;5790.739416726257;5858.443447872445;5865.4134586541;5871.471567558855;5916.585838991229;5965.403459654087;5977.1333156692035;5979.730912108966;5989.101634754822;5991.460768530766;4380.649548036149;4473.127740090651;4476.440444944382;4584.243599805995;4589.701669391479;4027.134166154291;4048.08917993455;4052.408893146548;4080.510338759368;4098.692598055158;5586.050371436865;5595.944040559623;5597.44025597437;5607.327120745536;5648.350439699405;5660.518855897295;5775.884482310415;5921.792737254175;5922.526197904157;5963.642181469126;5499.642523235977;5564.777408903679;5570.637908535932;5573.99668059745;5597.160425936061;5152.768125434364;5159.948400516022;5171.3535808024;5173.327467429285;5239.73801309933;5826.621269617462;5904.409559044061;5969.283685957713;6107.450329470191;6128;5994.910076348771;5999.070144127667;6004.39956004396;6004.42957918997;6025.849353766191;6089.54328425361;6135.907961380493;6137.754489820357;6139.29398119222;6179.28938172116;5443.727813609383;5559.638623489622;5600.159976003632;5768.2501274834;5849.64902105875;5882.764689412375;5921.437463440966;5929.0513517836935;5945.910811337747;5946.13781001761;5785.218995435731;5796.246487956707;5803.883922321445;5808.186853840381;5808.651480911159;5538.529225015919;5608.074667679787;5686.118651609007;5707.914381284367;5739.167820665896;5701.8859622806485;5711.5145212655725;5712.228849105484;5721.427857214246;5725.570582206268;5621;5757.769689212385;5782.855428614318;5797.507211887037;5797.681127538026;5602.047651899105;5630.324361076697;5716.399778023248;5722.055860783091;5778.191053252464 07:10:40 INFO - 2015-11-24 07:10:40,650 DEBUG : BROWSER_OUTPUT: |1;ext.html;555.1201345866801;597.271328978646;597.3250227243215;601.8024131977363;604.295995165632;30265.697343026564;39444;39610.80194599023;39618.40572391416;39628.20743585127;42546.14907701844;43266.351004734955;43355;43372.132557348836;43410.34884476735;7590.620468976556;7667.7316293929725;8629.180227878358;8654.22112009919;10139.695809125738;10438.791224175511;10465.633702820403;10475.423851688154;10552.419616921066;10558.1025612823;10554.366737995744;10659.200559957995;10669.413182274971;10672.09287210588;10679.946600266987;7905.169957154502;8126.228008339228;10541;10803.78392432147;10838.566457341696;10314.278000539965;10332.12176964959;10446.582136714522;10450.16398688103;10454.477276136238;38397.616023839684;38490.61509384898;38575.42136867921;38594.94753050945;38638;3292.851821668031;3306.718928891047;3331.716804071657;3584.551931008624;4020.839166433339;29111.85444072766;29467.263318416997;29476.41047179066;29797.851010745024;29954.55068173979;3933.429652700371;3959.227950549644;4047.615476529725;4103.076807718269;4187.183499217624;271468;272421.999999998;272761;274036;274686;53013;58783.70608146932;59276.70361648164;59294;59411.70294148588;50612;65837;66950.33049669441;67018.66490667613;67098.66450667813;15885.523434296989;15979.440719574759;16036;16092.597685057734;16119.597010074842;12257.325847078318;12355.75288494243;12356.25862448238;12359.38203089842;12381.195222310522;20001.499962501053;20610.896945515477;20766.1693532257;20779.68830467544;20822;8068.878966815502;8112.675492980333;8116.715914942949;8250.752477425687;8288.627011784483;894.2130924786277;896;955.9733365265681;1059.0838924330399;1089.145021158387;28173.154805355873;28196;28254.717452825207;28412.710243223934;28605.57091643627;987.09680642213;992.6079198716467;1019.23557332001;1050.8056009638242;1060.183658582887;14714;14745.483908063166;14819.259037048105;14983.850161498463;15013.399464021317;376474;381118;381231;382269;382545;51635.48364516382;52522.47477525252;52937.2059419109;52947.73526132345;52985.2052219217;1358.660334916271;1366.180291824917;1376.4150236149596;1381.8825399840925;1383.5918404070824;26794;27594.5860812092;27740.30649233785;27876.58185127184;28082;42177;42527.3620895693;46640.30039549477;47360.526394735614;52393.214101787744;270945;271387;273087;273303;273990;31990.200244994063;32358.676413235567;32363;32387.19032024218;32388.514172287905;33075.188608967546;37204;37800.62199377971;41517.79241103775;43991.78004110087;32797.016089517354;32908.83545582352;33430;33788.83105584457;33840.49239261462;35082.180424628306;36157.45763813597;36208.09479763027;36352.27295454023;36874.631253688196;34235.4864677035;34271.48592771061;34512.82743586266;34777.65222347744;34817.30365392729;30572.388552229277;31857;31951.36097278088;32193.839030804695;32368.83815580907;24440;24747.87626061858;24771.752282476944;24851.25446236616;25199.496010080064 07:10:40 INFO - 2015-11-24 07:10:40,650 DEBUG : BROWSER_OUTPUT: |2;jquery.html;359.72840505418407;360.5385107062959;363.4802232807086;365.2749292654083;366.90643885809124;14254.857451425483;14309.14145151289;16421.917890410547;16869.493915182535;17590.120493975315;10699.251052426333;11027.558897644085;16955.83044169561;17623.559411014732;17632.294708211655;4731.101090792738;4842.854714358575;4843.418789745236;4846.030793841228;4851.078295123915;3664.486971823947;3770.4344348347695;4820.542048505386;4833.734144622044;5213.426523082458;5258.3689957205;5321.946780532184;5336.252924590561;5337.973310133463;5344.5724342052545;5006.224035274557;5126.871828204287;5129.281900533928;5287.206918962148;5304.92042619361;4860.687614344142;4948.505149485059;4956.1822299320565;4974.303597496353;4979.502049794992;12313.322767247888;12566.120371573994;12581.559645412459;12583.874161258362;15455.381784728597;2024.9696254556193;2029.7767245602972;2061.5258490547108;2209.767974362701;2276.5560715660454;9304.953475232649;10366.844497332546;11869.228500147463;12904.16122952005;13665.590032299047;1793.1303317890813;1831.6977698679702;1864.4779461750732;1872.8782629129064;1931.1406424141262;61389.69305153446;62521.37478625201;64670;64950;65934.67032664854;9848.852267215998;10087.394756314645;10348.844767328495;10383.37699738003;10394.428306443218;13567.86432135666;13581.796273055912;13589.728205436033;13657.795133073012;13666.93166534161;7519.135299440634;7551.433642476836;7897.486663366863;7991.68033278674;8047.557384343917;7883.093444253869;7901.407394445439;7912.762617121495;7940.841183176304;7949.6025198739835;4234.894127646833;4302.698811083194;4399.73601583906;4431.512533621299;4436.778161091933;1649.089357284394;1673.3892129372691;1706;1759.551314414816;2925.4880395931054;866.2333834556463;867.0462491259564;910.5947853205261;1043.3983834813525;1051.2496693006212;16020.519384418487;16035.518934431986;16767.916160419365;16792.244349004322;17244.913775431043;816.9078160078291;845.602566793606;865.2602025268305;874.2394117118021;1014.1775855805744;9510.762230944143;9662.420254784736;9696.51517424126;9700.27247956392;9869.802603947881;549203;553847;554154;562032;562845;76150.61924690341;82054.58972705099;84483;85789.57105214434;88039.55980220185;1145.5532342386475;1149.0462915779883;1175.9176857619884;1195.227033573574;1202.3687564028955;15523.84476155224;15651.921740391224;15853.286602102702;15890.205489725698;15973.281202346156;36648.45027324539;37419.6258037427;37905.43141852819;38215.22309711286;38314.23371532498;47265;48802;49430.50569494259;49661.75169124131;49912;9390.577424015799;9435.386699864486;9581.473018984023;9586.856197157187;9603.663871764455;11092.833607495733;13129.868701313248;17858.821411785717;17989.190486428404;18077.36729214471;14558.199299038231;14579.198144101752;15148.697026059197;15195;15210.923945380202;14010.859891401364;14115.576532704035;14323.928380358031;14412.1352718833;14611.634709132357;12310.938445307716;12603.306818124724;14072.65239209094;14210.928945355621;15063.096214227182;8839.558022098741;8942.46345219289;8959.820803584022;9654.855177172489;9666.130048295687;10038.799224015625;13944.093633913762;14125.293735312987;14125.505607303696;14437.133771973715 07:10:40 INFO - 2015-11-24 07:10:40,650 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1325.0790700463183;1700.532353602759;1734.8612111031111;1750.8949463032216;1765.746320112719;6817.863642727142;7347.485676002682;7456.813579660511;7459.254074592538;7468.738594149206;7615.314621684048;7753.883691744629;7757.689692412297;7762.805929851743;7767.572783496906;1963;2003.1786967343392;2198.076807740753;2238.753737088919;2260.6495993121093;2285.7828506291958;2287.7369102553253;2294.265834932822;2298.908043678259;2301.2866011536476;2171.771963943787;2236.3626366485555;2237.0827960536185;2239.0819763896807;2242.2824696097255;1945.6400565895283;1983.841292696588;2133.381319417375;2159.179511785527;2169.5986242545177;2287.6797248385237;2291.873946932918;2311.9422014449606;2342.2856028911174;2343.484433424644;7669.041369828771;7758;7784.026996625422;7796.4932279401655;7823.726169584037;4799.992001679651;4866.853994380174;4904.117258893398;4908.214685650314;4909;2939.3092623233524;3008.0975707287944;3041.9543706844415;3042.34589563245;3053.129857990484;943.6084025129563;958.0898146760536;962.7003545213975;975.327024353194;984.867042949207;10745.194110441747;10876.293040952312;10887.401192934465;10891.455427228608;10902.61840835575;4186.581341865789;4256.87229383119;4311.547287534827;4318.1363727254675;4355.73865568067;8933.240674542607;8939.687110951085;8942.150495702897;8946.910530894738;8962.103789620985;4793.856184314476;4811.350467686888;4818.951810481921;4825.686330388514;4827.517248275215;4405.229084910128;4430.955690443118;4446.73319600825;4455.6658250631335;4457.866264012085;3518.3315170117594;3566.554180727409;3575.4636804479537;3590.8563657453933;3603.117236277129;1063.9308444951052;1089.5750657243682;1092.3937214845678;1119.7144728094283;1120.42858142348;1306.758249723804;1309.7576948264602;1318.1432069154935;1332.320516536554;1352.6618345413647;6550.8362290943105;6833.453323734089;7482.401407887356;7503.474756766974;7519.661615227218;426.45839783474815;432.35794844655663;434.03210839827364;434.30511182108376;437.47939951457664;5664.461876121762;5717.028105222123;5747.109198074305;5748.655080695172;5751.223584815996;9188.081191880758;9427.245820334358;9521.666741664008;9534.618615255313;9665.468399238109;9407.858882116774;9492.857607135898;9567.186789123003;9575.712728618153;9588.66439674608;7089.149302083783;7280.96359518199;7289.854202916018;7302.96348518254;7308.378787803096;7037.788866334018;7073.575585464683;7074.893876591958;7076.752313668997;7090.680919358538;7983.361331093614;8266.628001740057;8440.873386899324;8442.620082096197;8455.32357411418;8537.317014638938;8646.394752367274;8734.694285700225;8801.207891289814;8805.955970220108;6461.967690161707;6629.867402652017;6658;6663.600183988976;6674.399304062657;7630.694772209049;7686.923130768844;7700.383969282556;7703.3067023968115;7704.614769261402;7074.575525468488;7244.384227340735;7303.196648368569;7359.632018399166;7393.001944737607;6985.545939513915;7142.142942846892;7174.42604591621;7240.637968101679;7269.563826170447;7215.098112735908;7261.564306141649;7265.382442492447;7273.0908636420445;7273.309035641606;6430;6546.8363290918105;6601.834954125993;6610.570312929644;6611.305812889577;6643.800685979429;6711.731530738716;6733.562318449285;6753.020811982334;6755.594664320157 07:10:40 INFO - 2015-11-24 07:10:40,651 DEBUG : BROWSER_OUTPUT: |4;prototype.html;306.1977618639165;312.45788556853853;318.361684821932;323.5906578178603;331.99902294581824;5992.520598352132;6165.4142856428625;6178.814635560929;6186.56694031418;6212.099245609384;5951.404859514047;5998.010328295826;6032.69836508175;6045.727942242599;6053.424924632164;4440.755758433284;4537.2740361542155;4543.909121817562;4645.558671926162;4657.953420465794;4612.123696497655;4628;4631.861044168663;4645.163870503308;4660.743659098748;4587.977060114695;4600.378948841897;4600.516945720701;4606.838760643378;4608.1705293047235;4404.66964977628;4487.349334346534;4524.389207456984;4567.2692369221095;4590.357349971006;4016.4176194451643;4027.1140349123148;4031.314676505001;4031.7580945143386;4032.8386864525382;5700.885982280372;5712.8857422851725;5719.885602287973;5720.8283751487525;5722.771089156428;5239.921401178985;5301.125314323132;5313.495217954288;5315.654482458628;5323.0152421802095;6401.519886008568;6402.48780097591;6409.743610255584;6412.743490260384;6422.807315780534;4469.932951005738;4473.507914129443;4477.597016268519;4477.888052798674;4483.730976141442;6577.144971153767;6643.5017373697165;6657.034729964128;6661.9000714989315;6666.666666666647;4476.798544065525;4560.95439045612;4564.406627138451;4573.56551127649;4575.3823233863;4606.078784243165;4612.169809434267;4621.214393553104;4622.86131416058;4626.976865115653;5332.973335133377;5347.0909945309395;5348.304720386325;5350.5987050971335;5352.384475785257;6434.871302573923;6438.967805161038;6440.194975628046;6446.742130314735;6452.354534640775;1598.9120598367201;1633.093633033654;1636.9345226191058;1637.1159573830237;1637.909914954665;1077.6066735641434;1098.1653943003375;1103.6137351926923;1105.7512059786484;1117.0728295514702;6107.053406721965;6133.570650054543;6139.539534534928;6142.832861756341;6154.79981403622;6548.934510654928;6565.212174539086;6570.178727659043;6576.736930522821;6580.605163690194;6030.638161710312;6135.815925522242;6143.109249158936;6154.630722156685;6159.076138579249;3549.432090865449;3570.285942811396;3577.141486043331;3580.872025312018;3581.874634387836;6646.26891041985;6649.534532582673;6650.73397064112;6656.668666266766;6675.732970681119;6654.3345665434035;6664.533482656265;6735.562188457735;6738.764143254963;6748.122744043243;6730.091437655854;6920.411765000032;6944.548604340803;6945;6951.93048069523;6684.16447944007;6702.262751097278;6703.195616526048;6704;6712.060311556484;6428.228612566522;6514.185726784152;6581.736730530725;6621.33786621334;6627.536072474881;6904.13698287714;6905.998630198694;6910;6921.584704917721;6942.444604431735;4405;4426.800793964344;4428.446444194476;4430.113977204507;4432.800523976364;6583.958972718281;6653.600783952978;6667.099941507834;6668.399844014062;6674.766383176566;6338.461230795434;6435.292117866938;6466.41802237782;6504.73981040772;6510.121133646897;6479.416852483299;6490.318516555693;6497.707603157774;6499.772507962199;6500.674966251763;6227.782027629011;6377.649229292433;6384.648844313608;6395.488360931021;6397.232332120176;6532.314107018695;6534.117894084237;6534.1178940844275;6539.149910511603;6540.476761858945;6387.680615969276;6389.201349831271;6389.87220255583;6394.360563943755;6395.328490508429 07:10:40 INFO - 2015-11-24 07:10:40,652 DEBUG : BROWSER_OUTPUT: |5;yui.html;821.6425854753181;822.6051495282264;835.1106072033288;836.7866991806671;851.81260122773;14112.15327080376;14412.423503059892;14434.711305773879;14460.276986150677;14482.855171448282;13161.539346122887;14591.270436478188;14960.251987400614;14991.550253492385;15009.399624015026;689.1523426185795;824.3734761581211;836.6109758962082;836.7573403712946;837.6858677995751;688.717625773433;821.2854816309818;826.3430572694722;834.0491839303199;834.8288600836844;863.9006514250848;876.4741155306829;877.32007694037;877.5963056993791;878.8945326560822;716.3731734732136;719.3022767915166;850.5237067242302;865.5758678247677;866.1468453573225;627.9215098112736;628.2555172121006;629.6348118091496;630.4168644004278;630.5838146823121;13664.726705465935;14045.297735113305;14051.086679365808;14081.084729492653;14105.36525856339;11845.940770296093;11919.821202681967;12179.634610961686;12809.935950320189;12866.228026318357;10254.846177307347;10297.330673506198;10370.533326000348;10715.46422678863;10858.891411085946;3592.9749296152163;3642.7267954903486;3665.4135338345736;3670.2659468106485;3762.5108735864437;46476;47271;47564.28653570199;47633.523664763256;47703.76148119272;9751.17115045215;9952.253580981456;10038.598456061676;10144.188464922789;10201.693949181536;17725.379611713528;18220.08899555017;18256.81743182551;18266;18315.358962436516;7320.377767889789;7404.111506619241;7416.147143078507;7433.2566743326315;7789.221077892165;4034.0923292259595;4163.646090082377;4171.770552619574;4173.24881521323;4179.644730197967;3067.8619462124257;3081.4145312390574;3082.321889184376;3082.969170308313;3090.5209692497697;534.8448949804591;551.1842473139776;556.4852511426914;562.7917670461956;562.9971850140723;493.8666560028772;540.713421886393;627.9434850863444;640.5772190354344;674.6828990374614;7508.774736757797;7706.499077559941;7748.7675369739;7767.53394796314;7772.961135194401;569.6297406685604;621.0683974038942;637.9078213261965;679.3274658088457;679.653376777837;3517.8065206413894;3717.386631205875;3718.4422336649177;3844.154286057063;3866.033491627093;58446.41553584495;58931;59005.40994590085;59282.11076833851;59342;54236.728816355666;54702.72648636731;54772;55370.72314638401;55851;47548.5245147551;47692.7615361921;47906.760466198146;48466.75766621215;48640.75679621579;8145.79635509117;8324.25081742646;8424.747257582283;8437.451565648213;8544.957275213585;34420.65579344275;34789.65210347864;35127.29745405026;35266.82366588151;35429.46855797217;42799.7860010698;45867;47382.05235895332;47608;48025.519744802106;10685.732856678645;10990.725231869268;11014.296253464425;11084.757586327043;11325.660230193107;11822.172447928906;12101.339805344642;12233;12331.876681233072;12410.937945310216;10310.123639490428;10619;10651.254412191382;10776.29954052984;10845.511951962022;11514.88485115138;11756.529738810352;12115.15193936416;12262.938685306517;12608.810867836806;9973.551190196604;10346.534405951901;10357.9482102589;10533.473326333806;10642.627508037182;10008.499575021366;10222.335548189343;10398.740031499274;10562;10644.201684873511;8942.910570894208;8969.865452018355;9001.144891235323;9373.578188981375;9449.338546301693 07:10:40 INFO - 2015-11-24 07:10:40,653 DEBUG : BROWSER_OUTPUT: __end_tp_report 07:10:40 INFO - 2015-11-24 07:10:40,653 DEBUG : BROWSER_OUTPUT: __start_cc_report 07:10:40 INFO - 2015-11-24 07:10:40,653 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,978 07:10:40 INFO - 2015-11-24 07:10:40,653 DEBUG : BROWSER_OUTPUT: __end_cc_report 07:10:40 INFO - 2015-11-24 07:10:40,653 DEBUG : BROWSER_OUTPUT: __startTimestamp1448377840643__endTimestamp 07:10:40 INFO - 2015-11-24 07:10:40,653 DEBUG : BROWSER_OUTPUT: 07:10:40 INFO - 2015-11-24 07:10:40,653 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 07:10:40 INFO - 2015-11-24 07:10:40,653 DEBUG : BROWSER_OUTPUT: Number of tests: 6 07:10:40 INFO - 2015-11-24 07:10:40,654 DEBUG : BROWSER_OUTPUT: 07:10:40 INFO - 2015-11-24 07:10:40,654 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:5460.04 Median:5648.35 stddev:620.44 (11.0%) stddev-sans-first:594.41 07:10:40 INFO - 2015-11-24 07:10:40,654 DEBUG : BROWSER_OUTPUT: Values: 3113.5 3114.6 3199.7 3210.7 3223.8 5247.7 5333.0 5357.5 5429.5 5437.3 5300.2 5397.1 5398.2 5523.7 5525.6 4970.6 4995.7 5029.3 5042.5 5098.1 5019.1 5095.0 5109.4 5121.3 5140.3 4845.5 4907.0 4931.6 5052.1 5113.2 4901.5 4926.7 4943.9 5013.3 5026.6 4953.6 4984.1 5005.2 5007.9 5049.1 5132.4 5230.3 5282.4 5316.6 5325.7 5798.5 5803.1 5891.1 5908.0 5925.2 5836.8 5989.5 5989.6 6052.3 6052.5 5276.3 5563.1 5573.9 5575.1 5576.8 5840.9 5926.1 5933.3 5936.6 5945.6 5799.5 5813.4 5849.5 5851.7 5859.8 5697.1 5847.5 5944.0 5957.0 5958.8 5790.7 5858.4 5865.4 5871.5 5916.6 5965.4 5977.1 5979.7 5989.1 5991.5 4380.6 4473.1 4476.4 4584.2 4589.7 4027.1 4048.1 4052.4 4080.5 4098.7 5586.1 5595.9 5597.4 5607.3 5648.4 5660.5 5775.9 5921.8 5922.5 5963.6 5499.6 5564.8 5570.6 5574.0 5597.2 5152.8 5159.9 5171.4 5173.3 5239.7 5826.6 5904.4 5969.3 6107.5 6128.0 5994.9 5999.1 6004.4 6004.4 6025.8 6089.5 6135.9 6137.8 6139.3 6179.3 5443.7 5559.6 5600.2 5768.3 5849.6 5882.8 5921.4 5929.1 5945.9 5946.1 5785.2 5796.2 5803.9 5808.2 5808.7 5538.5 5608.1 5686.1 5707.9 5739.2 5701.9 5711.5 5712.2 5721.4 5725.6 5621.0 5757.8 5782.9 5797.5 5797.7 5602.0 5630.3 5716.4 5722.1 5778.2 07:10:40 INFO - 2015-11-24 07:10:40,654 DEBUG : BROWSER_OUTPUT: 07:10:40 INFO - 2015-11-24 07:10:40,654 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:47678.40 Median:32852.93 stddev:82048.56 (249.7%) stddev-sans-first:82202.44 07:10:40 INFO - 2015-11-24 07:10:40,654 DEBUG : BROWSER_OUTPUT: Values: 555.1 597.3 597.3 601.8 604.3 30265.7 39444.0 39610.8 39618.4 39628.2 42546.1 43266.4 43355.0 43372.1 43410.3 7590.6 7667.7 8629.2 8654.2 10139.7 10438.8 10465.6 10475.4 10552.4 10558.1 10554.4 10659.2 10669.4 10672.1 10679.9 7905.2 8126.2 10541.0 10803.8 10838.6 10314.3 10332.1 10446.6 10450.2 10454.5 38397.6 38490.6 38575.4 38594.9 38638.0 3292.9 3306.7 3331.7 3584.6 4020.8 29111.9 29467.3 29476.4 29797.9 29954.6 3933.4 3959.2 4047.6 4103.1 4187.2 271468.0 272422.0 272761.0 274036.0 274686.0 53013.0 58783.7 59276.7 59294.0 59411.7 50612.0 65837.0 66950.3 67018.7 67098.7 15885.5 15979.4 16036.0 16092.6 16119.6 12257.3 12355.8 12356.3 12359.4 12381.2 20001.5 20610.9 20766.2 20779.7 20822.0 8068.9 8112.7 8116.7 8250.8 8288.6 894.2 896.0 956.0 1059.1 1089.1 28173.2 28196.0 28254.7 28412.7 28605.6 987.1 992.6 1019.2 1050.8 1060.2 14714.0 14745.5 14819.3 14983.9 15013.4 376474.0 381118.0 381231.0 382269.0 382545.0 51635.5 52522.5 52937.2 52947.7 52985.2 1358.7 1366.2 1376.4 1381.9 1383.6 26794.0 27594.6 27740.3 27876.6 28082.0 42177.0 42527.4 46640.3 47360.5 52393.2 270945.0 271387.0 273087.0 273303.0 273990.0 31990.2 32358.7 32363.0 32387.2 32388.5 33075.2 37204.0 37800.6 41517.8 43991.8 32797.0 32908.8 33430.0 33788.8 33840.5 35082.2 36157.5 36208.1 36352.3 36874.6 34235.5 34271.5 34512.8 34777.7 34817.3 30572.4 31857.0 31951.4 32193.8 32368.8 24440.0 24747.9 24771.8 24851.3 25199.5 07:10:40 INFO - 2015-11-24 07:10:40,654 DEBUG : BROWSER_OUTPUT: 07:10:40 INFO - 2015-11-24 07:10:40,655 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:29340.55 Median:2015.70 stddev:91038.03 (4516.5%) stddev-sans-first:91267.41 07:10:40 INFO - 2015-11-24 07:10:40,656 DEBUG : BROWSER_OUTPUT: Values: 359.7 360.5 363.5 365.3 366.9 14254.9 14309.1 16421.9 16869.5 17590.1 10699.3 11027.6 16955.8 17623.6 17632.3 4731.1 4842.9 4843.4 4846.0 4851.1 3664.5 3770.4 4820.5 4833.7 5213.4 5258.4 5321.9 5336.3 5338.0 5344.6 5006.2 5126.9 5129.3 5287.2 5304.9 4860.7 4948.5 4956.2 4974.3 4979.5 12313.3 12566.1 12581.6 12583.9 15455.4 2025.0 2029.8 2061.5 2209.8 2276.6 9305.0 10366.8 11869.2 12904.2 13665.6 1793.1 1831.7 1864.5 1872.9 1931.1 61389.7 62521.4 64670.0 64950.0 65934.7 9848.9 10087.4 10348.8 10383.4 10394.4 13567.9 13581.8 13589.7 13657.8 13666.9 7519.1 7551.4 7897.5 7991.7 8047.6 7883.1 7901.4 7912.8 7940.8 7949.6 4234.9 4302.7 4399.7 4431.5 4436.8 1649.1 1673.4 1706.0 1759.6 2925.5 866.2 867.0 910.6 1043.4 1051.2 16020.5 16035.5 16767.9 16792.2 17244.9 816.9 845.6 865.3 874.2 1014.2 9510.8 9662.4 9696.5 9700.3 9869.8 549203.0 553847.0 554154.0 562032.0 562845.0 76150.6 82054.6 84483.0 85789.6 88039.6 1145.6 1149.0 1175.9 1195.2 1202.4 15523.8 15651.9 15853.3 15890.2 15973.3 36648.5 37419.6 37905.4 38215.2 38314.2 47265.0 48802.0 49430.5 49661.8 49912.0 9390.6 9435.4 9581.5 9586.9 9603.7 11092.8 13129.9 17858.8 17989.2 18077.4 14558.2 14579.2 15148.7 15195.0 15210.9 14010.9 14115.6 14323.9 14412.1 14611.6 12310.9 12603.3 14072.7 14210.9 15063.1 8839.6 8942.5 8959.8 9654.9 9666.1 10038.8 13944.1 14125.3 14125.5 14437.1 07:10:40 INFO - 2015-11-24 07:10:40,656 DEBUG : BROWSER_OUTPUT: 07:10:40 INFO - 2015-11-24 07:10:40,656 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5462.83 Median:6610.94 stddev:2875.25 (43.5%) stddev-sans-first:2866.49 07:10:40 INFO - 2015-11-24 07:10:40,656 DEBUG : BROWSER_OUTPUT: Values: 1325.1 1700.5 1734.9 1750.9 1765.7 6817.9 7347.5 7456.8 7459.3 7468.7 7615.3 7753.9 7757.7 7762.8 7767.6 1963.0 2003.2 2198.1 2238.8 2260.6 2285.8 2287.7 2294.3 2298.9 2301.3 2171.8 2236.4 2237.1 2239.1 2242.3 1945.6 1983.8 2133.4 2159.2 2169.6 2287.7 2291.9 2311.9 2342.3 2343.5 7669.0 7758.0 7784.0 7796.5 7823.7 4800.0 4866.9 4904.1 4908.2 4909.0 2939.3 3008.1 3042.0 3042.3 3053.1 943.6 958.1 962.7 975.3 984.9 10745.2 10876.3 10887.4 10891.5 10902.6 4186.6 4256.9 4311.5 4318.1 4355.7 8933.2 8939.7 8942.2 8946.9 8962.1 4793.9 4811.4 4819.0 4825.7 4827.5 4405.2 4431.0 4446.7 4455.7 4457.9 3518.3 3566.6 3575.5 3590.9 3603.1 1063.9 1089.6 1092.4 1119.7 1120.4 1306.8 1309.8 1318.1 1332.3 1352.7 6550.8 6833.5 7482.4 7503.5 7519.7 426.5 432.4 434.0 434.3 437.5 5664.5 5717.0 5747.1 5748.7 5751.2 9188.1 9427.2 9521.7 9534.6 9665.5 9407.9 9492.9 9567.2 9575.7 9588.7 7089.1 7281.0 7289.9 7303.0 7308.4 7037.8 7073.6 7074.9 7076.8 7090.7 7983.4 8266.6 8440.9 8442.6 8455.3 8537.3 8646.4 8734.7 8801.2 8806.0 6462.0 6629.9 6658.0 6663.6 6674.4 7630.7 7686.9 7700.4 7703.3 7704.6 7074.6 7244.4 7303.2 7359.6 7393.0 6985.5 7142.1 7174.4 7240.6 7269.6 7215.1 7261.6 7265.4 7273.1 7273.3 6430.0 6546.8 6601.8 6610.6 6611.3 6643.8 6711.7 6733.6 6753.0 6755.6 07:10:40 INFO - 2015-11-24 07:10:40,657 DEBUG : BROWSER_OUTPUT: 07:10:40 INFO - 2015-11-24 07:10:40,657 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:5366.45 Median:6141.19 stddev:1625.95 (26.5%) stddev-sans-first:1585.53 07:10:40 INFO - 2015-11-24 07:10:40,658 DEBUG : BROWSER_OUTPUT: Values: 306.2 312.5 318.4 323.6 332.0 5992.5 6165.4 6178.8 6186.6 6212.1 5951.4 5998.0 6032.7 6045.7 6053.4 4440.8 4537.3 4543.9 4645.6 4658.0 4612.1 4628.0 4631.9 4645.2 4660.7 4588.0 4600.4 4600.5 4606.8 4608.2 4404.7 4487.3 4524.4 4567.3 4590.4 4016.4 4027.1 4031.3 4031.8 4032.8 5700.9 5712.9 5719.9 5720.8 5722.8 5239.9 5301.1 5313.5 5315.7 5323.0 6401.5 6402.5 6409.7 6412.7 6422.8 4469.9 4473.5 4477.6 4477.9 4483.7 6577.1 6643.5 6657.0 6661.9 6666.7 4476.8 4561.0 4564.4 4573.6 4575.4 4606.1 4612.2 4621.2 4622.9 4627.0 5333.0 5347.1 5348.3 5350.6 5352.4 6434.9 6439.0 6440.2 6446.7 6452.4 1598.9 1633.1 1636.9 1637.1 1637.9 1077.6 1098.2 1103.6 1105.8 1117.1 6107.1 6133.6 6139.5 6142.8 6154.8 6548.9 6565.2 6570.2 6576.7 6580.6 6030.6 6135.8 6143.1 6154.6 6159.1 3549.4 3570.3 3577.1 3580.9 3581.9 6646.3 6649.5 6650.7 6656.7 6675.7 6654.3 6664.5 6735.6 6738.8 6748.1 6730.1 6920.4 6944.5 6945.0 6951.9 6684.2 6702.3 6703.2 6704.0 6712.1 6428.2 6514.2 6581.7 6621.3 6627.5 6904.1 6906.0 6910.0 6921.6 6942.4 4405.0 4426.8 4428.4 4430.1 4432.8 6584.0 6653.6 6667.1 6668.4 6674.8 6338.5 6435.3 6466.4 6504.7 6510.1 6479.4 6490.3 6497.7 6499.8 6500.7 6227.8 6377.6 6384.6 6395.5 6397.2 6532.3 6534.1 6534.1 6539.1 6540.5 6387.7 6389.2 6389.9 6394.4 6395.3 07:10:40 INFO - 2015-11-24 07:10:40,658 DEBUG : BROWSER_OUTPUT: 07:10:40 INFO - 2015-11-24 07:10:40,658 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:14030.79 Median:47326.53 stddev:16479.59 (34.8%) stddev-sans-first:16495.97 07:10:40 INFO - 2015-11-24 07:10:40,658 DEBUG : BROWSER_OUTPUT: Values: 821.6 822.6 835.1 836.8 851.8 14112.2 14412.4 14434.7 14460.3 14482.9 13161.5 14591.3 14960.3 14991.6 15009.4 689.2 824.4 836.6 836.8 837.7 688.7 821.3 826.3 834.0 834.8 863.9 876.5 877.3 877.6 878.9 716.4 719.3 850.5 865.6 866.1 627.9 628.3 629.6 630.4 630.6 13664.7 14045.3 14051.1 14081.1 14105.4 11845.9 11919.8 12179.6 12809.9 12866.2 10254.8 10297.3 10370.5 10715.5 10858.9 3593.0 3642.7 3665.4 3670.3 3762.5 46476.0 47271.0 47564.3 47633.5 47703.8 9751.2 9952.3 10038.6 10144.2 10201.7 17725.4 18220.1 18256.8 18266.0 18315.4 7320.4 7404.1 7416.1 7433.3 7789.2 4034.1 4163.6 4171.8 4173.2 4179.6 3067.9 3081.4 3082.3 3083.0 3090.5 534.8 551.2 556.5 562.8 563.0 493.9 540.7 627.9 640.6 674.7 7508.8 7706.5 7748.8 7767.5 7773.0 569.6 621.1 637.9 679.3 679.7 3517.8 3717.4 3718.4 3844.2 3866.0 58446.4 58931.0 59005.4 59282.1 59342.0 54236.7 54702.7 54772.0 55370.7 55851.0 47548.5 47692.8 47906.8 48466.8 48640.8 8145.8 8324.3 8424.7 8437.5 8545.0 34420.7 34789.7 35127.3 35266.8 35429.5 42799.8 45867.0 47382.1 47608.0 48025.5 10685.7 10990.7 11014.3 11084.8 11325.7 11822.2 12101.3 12233.0 12331.9 12410.9 10310.1 10619.0 10651.3 10776.3 10845.5 11514.9 11756.5 12115.2 12262.9 12608.8 9973.6 10346.5 10357.9 10533.5 10642.6 10008.5 10222.3 10398.7 10562.0 10644.2 8942.9 8969.9 9001.1 9373.6 9449.3 07:10:40 INFO - 2015-11-24 07:10:40,658 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 07:10:40 INFO - 2015-11-24 07:10:40,658 DEBUG : BROWSER_OUTPUT: 07:10:41 INFO - 2015-11-24 07:10:41,324 INFO : Browser exited with error code: 0 07:10:41 INFO - 2015-11-24 07:10:41,343 INFO : Completed test dromaeo_css (00:18:32) 07:10:41 INFO - 2015-11-24 07:10:41,343 INFO : Starting test kraken 07:10:41 INFO - 2015-11-24 07:10:41,343 DEBUG : operating with platform_type : linux_ 07:10:41 INFO - 2015-11-24 07:10:41,343 INFO : Initialising browser for kraken test... 07:10:41 INFO - 2015-11-24 07:10:41,350 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpEr4wwY/profile http://localhost:43074/getInfo.html 07:10:45 INFO - 2015-11-24 07:10:45,171 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 07:10:45 INFO - 2015-11-24 07:10:45,171 DEBUG : BROWSER_OUTPUT: colorDepth:24 07:10:45 INFO - 2015-11-24 07:10:45,172 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 07:10:45 INFO - 2015-11-24 07:10:45,172 DEBUG : BROWSER_OUTPUT: __metrics 07:10:45 INFO - 2015-11-24 07:10:45,293 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 07:10:46 INFO - 2015-11-24 07:10:46,469 INFO : Browser initialized. 07:10:46 INFO - 2015-11-24 07:10:46,469 INFO : Running cycle 1/1 for kraken test... 07:10:46 INFO - 2015-11-24 07:10:46,469 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpEr4wwY/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 07:10:58 INFO - 2015-11-24 07:10:58,224 DEBUG : BROWSER_OUTPUT: RSS: Main: 140029952 07:10:58 INFO - 2015-11-24 07:10:58,224 DEBUG : BROWSER_OUTPUT: 07:11:00 INFO - 2015-11-24 07:11:00,680 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43074/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:43074/tests/kraken/driver.html?testName=audio-beat-detection) 07:11:01 INFO - 2015-11-24 07:11:01,253 DEBUG : BROWSER_OUTPUT: RSS: Main: 179212288 07:11:01 INFO - 2015-11-24 07:11:01,254 DEBUG : BROWSER_OUTPUT: 07:11:03 INFO - 2015-11-24 07:11:03,870 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43074/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:43074/tests/kraken/driver.html?testName=audio-dft) 07:11:04 INFO - 2015-11-24 07:11:04,439 DEBUG : BROWSER_OUTPUT: RSS: Main: 168910848 07:11:04 INFO - 2015-11-24 07:11:04,439 DEBUG : BROWSER_OUTPUT: 07:11:07 INFO - 2015-11-24 07:11:07,351 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43074/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:43074/tests/kraken/driver.html?testName=audio-fft) 07:11:07 INFO - 2015-11-24 07:11:07,912 DEBUG : BROWSER_OUTPUT: RSS: Main: 151052288 07:11:07 INFO - 2015-11-24 07:11:07,912 DEBUG : BROWSER_OUTPUT: 07:11:09 INFO - 2015-11-24 07:11:09,906 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43074/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:43074/tests/kraken/driver.html?testName=audio-oscillator) 07:11:10 INFO - 2015-11-24 07:11:10,471 DEBUG : BROWSER_OUTPUT: RSS: Main: 154181632 07:11:10 INFO - 2015-11-24 07:11:10,472 DEBUG : BROWSER_OUTPUT: 07:11:12 INFO - 2015-11-24 07:11:12,667 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43074/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:43074/tests/kraken/driver.html?testName=imaging-gaussian-blur) 07:11:13 INFO - 2015-11-24 07:11:13,228 DEBUG : BROWSER_OUTPUT: RSS: Main: 156966912 07:11:13 INFO - 2015-11-24 07:11:13,228 DEBUG : BROWSER_OUTPUT: 07:11:16 INFO - 2015-11-24 07:11:16,127 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43074/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:43074/tests/kraken/driver.html?testName=imaging-darkroom) 07:11:16 INFO - 2015-11-24 07:11:16,694 DEBUG : BROWSER_OUTPUT: RSS: Main: 156688384 07:11:16 INFO - 2015-11-24 07:11:16,694 DEBUG : BROWSER_OUTPUT: 07:11:20 INFO - 2015-11-24 07:11:20,049 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43074/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:43074/tests/kraken/driver.html?testName=imaging-desaturate) 07:11:20 INFO - 2015-11-24 07:11:20,622 DEBUG : BROWSER_OUTPUT: RSS: Main: 158031872 07:11:20 INFO - 2015-11-24 07:11:20,622 DEBUG : BROWSER_OUTPUT: 07:11:23 INFO - 2015-11-24 07:11:23,380 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43074/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:43074/tests/kraken/driver.html?testName=json-parse-financial) 07:11:23 INFO - 2015-11-24 07:11:23,961 DEBUG : BROWSER_OUTPUT: RSS: Main: 157822976 07:11:23 INFO - 2015-11-24 07:11:23,962 DEBUG : BROWSER_OUTPUT: 07:11:25 INFO - 2015-11-24 07:11:25,571 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43074/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:43074/tests/kraken/driver.html?testName=json-stringify-tinderbox) 07:11:26 INFO - 2015-11-24 07:11:26,134 DEBUG : BROWSER_OUTPUT: RSS: Main: 171642880 07:11:26 INFO - 2015-11-24 07:11:26,134 DEBUG : BROWSER_OUTPUT: 07:11:27 INFO - 2015-11-24 07:11:27,956 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43074/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:43074/tests/kraken/driver.html?testName=stanford-crypto-aes) 07:11:28 INFO - 2015-11-24 07:11:28,558 DEBUG : BROWSER_OUTPUT: RSS: Main: 165298176 07:11:28 INFO - 2015-11-24 07:11:28,558 DEBUG : BROWSER_OUTPUT: 07:11:30 INFO - 2015-11-24 07:11:30,591 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43074/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:43074/tests/kraken/driver.html?testName=stanford-crypto-ccm) 07:11:31 INFO - 2015-11-24 07:11:31,158 DEBUG : BROWSER_OUTPUT: RSS: Main: 173252608 07:11:31 INFO - 2015-11-24 07:11:31,158 DEBUG : BROWSER_OUTPUT: 07:11:33 INFO - 2015-11-24 07:11:33,553 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43074/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:43074/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 07:11:34 INFO - 2015-11-24 07:11:34,125 DEBUG : BROWSER_OUTPUT: RSS: Main: 180101120 07:11:34 INFO - 2015-11-24 07:11:34,126 DEBUG : BROWSER_OUTPUT: 07:11:36 INFO - 2015-11-24 07:11:36,681 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43074/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:43074/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 07:11:37 INFO - 2015-11-24 07:11:37,249 DEBUG : BROWSER_OUTPUT: RSS: Main: 179265536 07:11:37 INFO - 2015-11-24 07:11:37,250 DEBUG : BROWSER_OUTPUT: 07:11:38 INFO - 2015-11-24 07:11:38,902 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43074/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:43074/tests/kraken/driver.html?testName=ai-astar) 07:11:39 INFO - 2015-11-24 07:11:39,152 DEBUG : BROWSER_OUTPUT: RSS: Main: 237854720 07:11:39 INFO - 2015-11-24 07:11:39,152 DEBUG : BROWSER_OUTPUT: 07:11:39 INFO - 2015-11-24 07:11:39,156 DEBUG : BROWSER_OUTPUT: __start_tp_report 07:11:39 INFO - 2015-11-24 07:11:39,156 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 07:11:39 INFO - 2015-11-24 07:11:39,156 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 07:11:39 INFO - 2015-11-24 07:11:39,156 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 07:11:39 INFO - 2015-11-24 07:11:39,156 DEBUG : BROWSER_OUTPUT: |0;ai-astar;107;109;102;110;110;110;98;108;108;99 07:11:39 INFO - 2015-11-24 07:11:39,156 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;159;123;154;163;125;149;149;122;170;122 07:11:39 INFO - 2015-11-24 07:11:39,156 DEBUG : BROWSER_OUTPUT: |2;audio-dft;161;160;162;160;160;160;160;162;161;162 07:11:39 INFO - 2015-11-24 07:11:39,156 DEBUG : BROWSER_OUTPUT: |3;audio-fft;72;71;81;93;71;73;71;116;95;71 07:11:39 INFO - 2015-11-24 07:11:39,157 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;93;94;145;94;94;94;134;94;94;137 07:11:39 INFO - 2015-11-24 07:11:39,157 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;109;109;110;111;109;110;109;109;109;109 07:11:39 INFO - 2015-11-24 07:11:39,157 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;147;146;147;145;146;147;146;145;146;145 07:11:39 INFO - 2015-11-24 07:11:39,157 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;96;96;95;96;96;96;97;96;96;95 07:11:39 INFO - 2015-11-24 07:11:39,157 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;62;62;62;63;63;62;65;62;64;60 07:11:39 INFO - 2015-11-24 07:11:39,157 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;68;68;68;68;68;69;83;68;69;69 07:11:39 INFO - 2015-11-24 07:11:39,157 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;84;83;83;84;84;92;84;85;85;85 07:11:39 INFO - 2015-11-24 07:11:39,158 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;130;120;112;111;140;114;122;118;124;116 07:11:39 INFO - 2015-11-24 07:11:39,158 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;139;146;158;148;152;137;149;152;152;143 07:11:39 INFO - 2015-11-24 07:11:39,158 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;65;65;66;67;68;67;66;66;66;65 07:11:39 INFO - 2015-11-24 07:11:39,158 DEBUG : BROWSER_OUTPUT: __end_tp_report 07:11:39 INFO - 2015-11-24 07:11:39,158 DEBUG : BROWSER_OUTPUT: __start_cc_report 07:11:39 INFO - 2015-11-24 07:11:39,158 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,913 07:11:39 INFO - 2015-11-24 07:11:39,158 DEBUG : BROWSER_OUTPUT: __end_cc_report 07:11:39 INFO - 2015-11-24 07:11:39,158 DEBUG : BROWSER_OUTPUT: __startTimestamp1448377899154__endTimestamp 07:11:39 INFO - 2015-11-24 07:11:39,159 DEBUG : BROWSER_OUTPUT: 07:11:39 INFO - 2015-11-24 07:11:39,162 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 07:11:39 INFO - 2015-11-24 07:11:39,162 DEBUG : BROWSER_OUTPUT: Number of tests: 14 07:11:39 INFO - 2015-11-24 07:11:39,162 DEBUG : BROWSER_OUTPUT: 07:11:39 INFO - 2015-11-24 07:11:39,162 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:106.10 Median:110.00 stddev:4.65 (4.2%) stddev-sans-first:4.92 07:11:39 INFO - 2015-11-24 07:11:39,162 DEBUG : BROWSER_OUTPUT: Values: 107.0 109.0 102.0 110.0 110.0 110.0 98.0 108.0 108.0 99.0 07:11:39 INFO - 2015-11-24 07:11:39,162 DEBUG : BROWSER_OUTPUT: 07:11:39 INFO - 2015-11-24 07:11:39,163 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:143.60 Median:151.50 stddev:18.80 (12.4%) stddev-sans-first:19.09 07:11:39 INFO - 2015-11-24 07:11:39,163 DEBUG : BROWSER_OUTPUT: Values: 159.0 123.0 154.0 163.0 125.0 149.0 149.0 122.0 170.0 122.0 07:11:39 INFO - 2015-11-24 07:11:39,163 DEBUG : BROWSER_OUTPUT: 07:11:39 INFO - 2015-11-24 07:11:39,163 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:160.80 Median:161.00 stddev:0.92 (0.6%) stddev-sans-first:0.97 07:11:39 INFO - 2015-11-24 07:11:39,163 DEBUG : BROWSER_OUTPUT: Values: 161.0 160.0 162.0 160.0 160.0 160.0 160.0 162.0 161.0 162.0 07:11:39 INFO - 2015-11-24 07:11:39,163 DEBUG : BROWSER_OUTPUT: 07:11:39 INFO - 2015-11-24 07:11:39,163 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:81.40 Median:72.50 stddev:15.31 (21.1%) stddev-sans-first:15.85 07:11:39 INFO - 2015-11-24 07:11:39,163 DEBUG : BROWSER_OUTPUT: Values: 72.0 71.0 81.0 93.0 71.0 73.0 71.0 116.0 95.0 71.0 07:11:39 INFO - 2015-11-24 07:11:39,163 DEBUG : BROWSER_OUTPUT: 07:11:39 INFO - 2015-11-24 07:11:39,163 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:107.30 Median:94.00 stddev:21.81 (23.2%) stddev-sans-first:22.51 07:11:39 INFO - 2015-11-24 07:11:39,163 DEBUG : BROWSER_OUTPUT: Values: 93.0 94.0 145.0 94.0 94.0 94.0 134.0 94.0 94.0 137.0 07:11:39 INFO - 2015-11-24 07:11:39,163 DEBUG : BROWSER_OUTPUT: 07:11:39 INFO - 2015-11-24 07:11:39,163 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:109.40 Median:109.00 stddev:0.70 (0.6%) stddev-sans-first:0.73 07:11:39 INFO - 2015-11-24 07:11:39,164 DEBUG : BROWSER_OUTPUT: Values: 109.0 109.0 110.0 111.0 109.0 110.0 109.0 109.0 109.0 109.0 07:11:39 INFO - 2015-11-24 07:11:39,164 DEBUG : BROWSER_OUTPUT: 07:11:39 INFO - 2015-11-24 07:11:39,164 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:146.00 Median:146.00 stddev:0.82 (0.6%) stddev-sans-first:0.78 07:11:39 INFO - 2015-11-24 07:11:39,164 DEBUG : BROWSER_OUTPUT: Values: 147.0 146.0 147.0 145.0 146.0 147.0 146.0 145.0 146.0 145.0 07:11:39 INFO - 2015-11-24 07:11:39,164 DEBUG : BROWSER_OUTPUT: 07:11:39 INFO - 2015-11-24 07:11:39,164 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:95.90 Median:96.00 stddev:0.57 (0.6%) stddev-sans-first:0.60 07:11:39 INFO - 2015-11-24 07:11:39,164 DEBUG : BROWSER_OUTPUT: Values: 96.0 96.0 95.0 96.0 96.0 96.0 97.0 96.0 96.0 95.0 07:11:39 INFO - 2015-11-24 07:11:39,164 DEBUG : BROWSER_OUTPUT: 07:11:39 INFO - 2015-11-24 07:11:39,164 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:62.50 Median:62.50 stddev:1.35 (2.2%) stddev-sans-first:1.42 07:11:39 INFO - 2015-11-24 07:11:39,164 DEBUG : BROWSER_OUTPUT: Values: 62.0 62.0 62.0 63.0 63.0 62.0 65.0 62.0 64.0 60.0 07:11:39 INFO - 2015-11-24 07:11:39,164 DEBUG : BROWSER_OUTPUT: 07:11:39 INFO - 2015-11-24 07:11:39,164 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:69.80 Median:68.50 stddev:4.66 (6.8%) stddev-sans-first:4.90 07:11:39 INFO - 2015-11-24 07:11:39,164 DEBUG : BROWSER_OUTPUT: Values: 68.0 68.0 68.0 68.0 68.0 69.0 83.0 68.0 69.0 69.0 07:11:39 INFO - 2015-11-24 07:11:39,165 DEBUG : BROWSER_OUTPUT: 07:11:39 INFO - 2015-11-24 07:11:39,165 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:84.90 Median:84.50 stddev:2.60 (3.1%) stddev-sans-first:2.74 07:11:39 INFO - 2015-11-24 07:11:39,165 DEBUG : BROWSER_OUTPUT: Values: 84.0 83.0 83.0 84.0 84.0 92.0 84.0 85.0 85.0 85.0 07:11:39 INFO - 2015-11-24 07:11:39,165 DEBUG : BROWSER_OUTPUT: 07:11:39 INFO - 2015-11-24 07:11:39,165 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:120.70 Median:121.00 stddev:8.92 (7.4%) stddev-sans-first:8.80 07:11:39 INFO - 2015-11-24 07:11:39,165 DEBUG : BROWSER_OUTPUT: Values: 130.0 120.0 112.0 111.0 140.0 114.0 122.0 118.0 124.0 116.0 07:11:39 INFO - 2015-11-24 07:11:39,165 DEBUG : BROWSER_OUTPUT: 07:11:39 INFO - 2015-11-24 07:11:39,165 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:147.60 Median:150.50 stddev:6.48 (4.3%) stddev-sans-first:6.09 07:11:39 INFO - 2015-11-24 07:11:39,165 DEBUG : BROWSER_OUTPUT: Values: 139.0 146.0 158.0 148.0 152.0 137.0 149.0 152.0 152.0 143.0 07:11:39 INFO - 2015-11-24 07:11:39,165 DEBUG : BROWSER_OUTPUT: 07:11:39 INFO - 2015-11-24 07:11:39,165 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.10 Median:66.00 stddev:0.99 (1.5%) stddev-sans-first:0.97 07:11:39 INFO - 2015-11-24 07:11:39,165 DEBUG : BROWSER_OUTPUT: Values: 65.0 65.0 66.0 67.0 68.0 67.0 66.0 66.0 66.0 65.0 07:11:39 INFO - 2015-11-24 07:11:39,165 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 07:11:39 INFO - 2015-11-24 07:11:39,165 DEBUG : BROWSER_OUTPUT: 07:11:39 INFO - 2015-11-24 07:11:39,993 INFO : Browser exited with error code: 0 07:11:40 INFO - 2015-11-24 07:11:40,048 INFO : Completed test kraken (00:00:58) 07:11:40 INFO - 2015-11-24 07:11:40,048 INFO : Starting test v8_7 07:11:40 INFO - 2015-11-24 07:11:40,048 DEBUG : operating with platform_type : linux_ 07:11:40 INFO - 2015-11-24 07:11:40,048 INFO : Initialising browser for v8_7 test... 07:11:40 INFO - 2015-11-24 07:11:40,054 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpyxKoKK/profile http://localhost:43074/getInfo.html 07:11:43 INFO - 2015-11-24 07:11:43,667 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 07:11:43 INFO - 2015-11-24 07:11:43,667 DEBUG : BROWSER_OUTPUT: colorDepth:24 07:11:43 INFO - 2015-11-24 07:11:43,667 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 07:11:43 INFO - 2015-11-24 07:11:43,667 DEBUG : BROWSER_OUTPUT: __metrics 07:11:43 INFO - 2015-11-24 07:11:43,748 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 07:11:45 INFO - 2015-11-24 07:11:45,091 INFO : Browser initialized. 07:11:45 INFO - 2015-11-24 07:11:45,092 INFO : Running cycle 1/1 for v8_7 test... 07:11:45 INFO - 2015-11-24 07:11:45,092 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpyxKoKK/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 07:11:56 INFO - 2015-11-24 07:11:56,846 DEBUG : BROWSER_OUTPUT: RSS: Main: 140328960 07:11:56 INFO - 2015-11-24 07:11:56,846 DEBUG : BROWSER_OUTPUT: 07:12:18 INFO - 2015-11-24 07:12:18,222 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43074/tests/v8_7/run.html (next: http://localhost:43074/tests/v8_7/run.html) 07:12:18 INFO - 2015-11-24 07:12:18,472 DEBUG : BROWSER_OUTPUT: RSS: Main: 568229888 07:12:18 INFO - 2015-11-24 07:12:18,472 DEBUG : BROWSER_OUTPUT: 07:12:18 INFO - 2015-11-24 07:12:18,474 DEBUG : BROWSER_OUTPUT: __start_tp_report 07:12:18 INFO - 2015-11-24 07:12:18,474 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 07:12:18 INFO - 2015-11-24 07:12:18,474 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 07:12:18 INFO - 2015-11-24 07:12:18,474 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 07:12:18 INFO - 2015-11-24 07:12:18,474 DEBUG : BROWSER_OUTPUT: |0;Richards;190.22256039566292 07:12:18 INFO - 2015-11-24 07:12:18,474 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;194.43904335990666 07:12:18 INFO - 2015-11-24 07:12:18,474 DEBUG : BROWSER_OUTPUT: |2;Encrypt;287.93550244745177 07:12:18 INFO - 2015-11-24 07:12:18,475 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5010 07:12:18 INFO - 2015-11-24 07:12:18,475 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1974.3589743589744 07:12:18 INFO - 2015-11-24 07:12:18,475 DEBUG : BROWSER_OUTPUT: |5;Earley;758.1501137225171 07:12:18 INFO - 2015-11-24 07:12:18,475 DEBUG : BROWSER_OUTPUT: |6;Boyer;12231.707317073171 07:12:18 INFO - 2015-11-24 07:12:18,475 DEBUG : BROWSER_OUTPUT: |7;RegExp;25175 07:12:18 INFO - 2015-11-24 07:12:18,475 DEBUG : BROWSER_OUTPUT: |8;Splay;647.2491909385113 07:12:18 INFO - 2015-11-24 07:12:18,476 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4850.241545893719 07:12:18 INFO - 2015-11-24 07:12:18,476 DEBUG : BROWSER_OUTPUT: __end_tp_report 07:12:18 INFO - 2015-11-24 07:12:18,476 DEBUG : BROWSER_OUTPUT: __startTimestamp1448377938472__endTimestamp 07:12:18 INFO - 2015-11-24 07:12:18,476 DEBUG : BROWSER_OUTPUT: 07:12:18 INFO - 2015-11-24 07:12:18,476 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 07:12:18 INFO - 2015-11-24 07:12:18,476 DEBUG : BROWSER_OUTPUT: Number of tests: 10 07:12:18 INFO - 2015-11-24 07:12:18,477 DEBUG : BROWSER_OUTPUT: 07:12:18 INFO - 2015-11-24 07:12:18,477 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:190.22 Median:190.22 stddev:0.00 (0.0%) 07:12:18 INFO - 2015-11-24 07:12:18,478 DEBUG : BROWSER_OUTPUT: Values: 190.2 07:12:18 INFO - 2015-11-24 07:12:18,478 DEBUG : BROWSER_OUTPUT: 07:12:18 INFO - 2015-11-24 07:12:18,478 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:194.44 Median:194.44 stddev:0.00 (0.0%) 07:12:18 INFO - 2015-11-24 07:12:18,479 DEBUG : BROWSER_OUTPUT: Values: 194.4 07:12:18 INFO - 2015-11-24 07:12:18,479 DEBUG : BROWSER_OUTPUT: 07:12:18 INFO - 2015-11-24 07:12:18,479 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:287.94 Median:287.94 stddev:0.00 (0.0%) 07:12:18 INFO - 2015-11-24 07:12:18,479 DEBUG : BROWSER_OUTPUT: Values: 287.9 07:12:18 INFO - 2015-11-24 07:12:18,479 DEBUG : BROWSER_OUTPUT: 07:12:18 INFO - 2015-11-24 07:12:18,479 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5010.00 Median:5010.00 stddev:0.00 (0.0%) 07:12:18 INFO - 2015-11-24 07:12:18,479 DEBUG : BROWSER_OUTPUT: Values: 5010.0 07:12:18 INFO - 2015-11-24 07:12:18,480 DEBUG : BROWSER_OUTPUT: 07:12:18 INFO - 2015-11-24 07:12:18,480 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1974.36 Median:1974.36 stddev:0.00 (0.0%) 07:12:18 INFO - 2015-11-24 07:12:18,480 DEBUG : BROWSER_OUTPUT: Values: 1974.4 07:12:18 INFO - 2015-11-24 07:12:18,480 DEBUG : BROWSER_OUTPUT: 07:12:18 INFO - 2015-11-24 07:12:18,480 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:758.15 Median:758.15 stddev:0.00 (0.0%) 07:12:18 INFO - 2015-11-24 07:12:18,480 DEBUG : BROWSER_OUTPUT: Values: 758.2 07:12:18 INFO - 2015-11-24 07:12:18,480 DEBUG : BROWSER_OUTPUT: 07:12:18 INFO - 2015-11-24 07:12:18,481 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:12231.71 Median:12231.71 stddev:0.00 (0.0%) 07:12:18 INFO - 2015-11-24 07:12:18,481 DEBUG : BROWSER_OUTPUT: Values: 12231.7 07:12:18 INFO - 2015-11-24 07:12:18,481 DEBUG : BROWSER_OUTPUT: 07:12:18 INFO - 2015-11-24 07:12:18,481 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:25175.00 Median:25175.00 stddev:0.00 (0.0%) 07:12:18 INFO - 2015-11-24 07:12:18,481 DEBUG : BROWSER_OUTPUT: Values: 25175.0 07:12:18 INFO - 2015-11-24 07:12:18,481 DEBUG : BROWSER_OUTPUT: 07:12:18 INFO - 2015-11-24 07:12:18,481 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:647.25 Median:647.25 stddev:0.00 (0.0%) 07:12:18 INFO - 2015-11-24 07:12:18,482 DEBUG : BROWSER_OUTPUT: Values: 647.2 07:12:18 INFO - 2015-11-24 07:12:18,482 DEBUG : BROWSER_OUTPUT: 07:12:18 INFO - 2015-11-24 07:12:18,482 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4850.24 Median:4850.24 stddev:0.00 (0.0%) 07:12:18 INFO - 2015-11-24 07:12:18,482 DEBUG : BROWSER_OUTPUT: Values: 4850.2 07:12:18 INFO - 2015-11-24 07:12:18,482 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 07:12:18 INFO - 2015-11-24 07:12:18,482 DEBUG : BROWSER_OUTPUT: 07:12:19 INFO - 2015-11-24 07:12:19,313 INFO : Browser exited with error code: 0 07:12:19 INFO - 2015-11-24 07:12:19,327 INFO : Completed test v8_7 (00:00:39) 07:12:19 INFO - 2015-11-24 07:12:19,495 INFO : Completed test suite (00:20:10) 07:12:19 INFO - 2015-11-24 07:12:19,495 DEBUG : Working with test: dromaeo_css 07:12:19 INFO - 2015-11-24 07:12:19,495 DEBUG : Generating results file: dromaeo_css 07:12:19 INFO - 2015-11-24 07:12:19,496 DEBUG : Working with test: kraken 07:12:19 INFO - 2015-11-24 07:12:19,496 DEBUG : Generating results file: kraken 07:12:19 INFO - 2015-11-24 07:12:19,497 INFO : javascript benchmark 07:12:19 INFO - 2015-11-24 07:12:19,497 DEBUG : Working with test: v8_7 07:12:19 INFO - 2015-11-24 07:12:19,497 DEBUG : Generating results file: v8_7 07:12:19 INFO - 2015-11-24 07:12:19,497 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 07:12:19 INFO - 2015-11-24 07:12:19,557 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,201,35]] 07:12:19 INFO - 2015-11-24 07:12:19,557 DEBUG : process_Request line: dromaeo_css 7014.90 graph.html#tests=[[72,201,35]] 07:12:19 INFO - 2015-11-24 07:12:19,557 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 07:12:19 INFO - 2015-11-24 07:12:19,589 DEBUG : process_Request line: kraken 1502.10 graph.html#tests=[[232,201,35]] 07:12:19 INFO - 2015-11-24 07:12:19,589 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 07:12:19 INFO - 2015-11-24 07:12:19,630 DEBUG : process_Request line: v8_7 19524.89 graph.html#tests=[[230,201,35]] 07:12:19 INFO - 2015-11-24 07:12:19,631 INFO : javascript benchmark 07:12:19 INFO - 2015-11-24 07:12:19,635 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3113.5018397056474, 3114.6106736657916, 3199.712025917667, 3210.7270881975032, 3223.7743357964937, 5247.658902171356, 5333.040052790496, 5357.491038351351, 5429.4570542945685, 5437.265969094176, 5300.204969254613, 5397.082495975684, 5398.217258497515, 5523.696196709179, 5525.585581081415, 4970.627202959774, 4995.725235112068, 5029.321041659366, 5042.520960508746, 5098.082345177866, 5019.071471777715, 5095.0, 5109.386873575176, 5121.257417674435, 5140.306058682087, 4845.466998630148, 4906.975465122688, 4931.556159945622, 5052.14113600687, 5113.233015047754, 4901.50984901507, 4926.679765815211, 4943.9258411123865, 5013.273075404046, 5026.5727413169925, 4953.5541801237705, 4984.102861484931, 5005.249212618136, 5007.92488112675, 5049.091163590552, 5132.435432102466, 5230.293910322096, 5282.445343238982, 5316.627836051478, 5325.680459172462, 5798.507126894219, 5803.071508558653, 5891.116332550109, 5907.9704601476715, 5925.229720136398, 5836.766529338822, 5989.460948514655, 5989.55078369124, 6052.334243233285, 6052.4552790248645, 5276.287701160371, 5563.082091454905, 5573.9163912540935, 5575.0522411190195, 5576.804811831566, 5840.912386314124, 5926.081457374114, 5933.317668468095, 5936.614120082181, 5945.64326140433, 5799.507041901401, 5813.418658134153, 5849.473547380671, 5851.6781577012825, 5859.794907178313, 5697.088465845445, 5847.502962248256, 5944.048952167633, 5957.0, 5958.76164953397, 5790.739416726257, 5858.443447872445, 5865.4134586541, 5871.471567558855, 5916.585838991229, 5965.403459654087, 5977.1333156692035, 5979.730912108966, 5989.101634754822, 5991.460768530766, 4380.649548036149, 4473.127740090651, 4476.440444944382, 4584.243599805995, 4589.701669391479, 4027.134166154291, 4048.08917993455, 4052.408893146548, 4080.510338759368, 4098.692598055158, 5586.050371436865, 5595.944040559623, 5597.44025597437, 5607.327120745536, 5648.350439699405, 5660.518855897295, 5775.884482310415, 5921.792737254175, 5922.526197904157, 5963.642181469126, 5499.642523235977, 5564.777408903679, 5570.637908535932, 5573.99668059745, 5597.160425936061, 5152.768125434364, 5159.948400516022, 5171.3535808024, 5173.327467429285, 5239.73801309933, 5826.621269617462, 5904.409559044061, 5969.283685957713, 6107.450329470191, 6128.0, 5994.910076348771, 5999.070144127667, 6004.39956004396, 6004.42957918997, 6025.849353766191, 6089.54328425361, 6135.907961380493, 6137.754489820357, 6139.29398119222, 6179.28938172116, 5443.727813609383, 5559.638623489622, 5600.159976003632, 5768.2501274834, 5849.64902105875, 5882.764689412375, 5921.437463440966, 5929.0513517836935, 5945.910811337747, 5946.13781001761, 5785.218995435731, 5796.246487956707, 5803.883922321445, 5808.186853840381, 5808.651480911159, 5538.529225015919, 5608.074667679787, 5686.118651609007, 5707.914381284367, 5739.167820665896, 5701.8859622806485, 5711.5145212655725, 5712.228849105484, 5721.427857214246, 5725.570582206268, 5621.0, 5757.769689212385, 5782.855428614318, 5797.507211887037, 5797.681127538026, 5602.047651899105, 5630.324361076697, 5716.399778023248, 5722.055860783091, 5778.191053252464], "unit": "ms", "name": "dojo.html", "value": 5418.395447607189}, {"lowerIsBetter": false, "replicates": [555.1201345866801, 597.271328978646, 597.3250227243215, 601.8024131977363, 604.295995165632, 30265.697343026564, 39444.0, 39610.80194599023, 39618.40572391416, 39628.20743585127, 42546.14907701844, 43266.351004734955, 43355.0, 43372.132557348836, 43410.34884476735, 7590.620468976556, 7667.7316293929725, 8629.180227878358, 8654.22112009919, 10139.695809125738, 10438.791224175511, 10465.633702820403, 10475.423851688154, 10552.419616921066, 10558.1025612823, 10554.366737995744, 10659.200559957995, 10669.413182274971, 10672.09287210588, 10679.946600266987, 7905.169957154502, 8126.228008339228, 10541.0, 10803.78392432147, 10838.566457341696, 10314.278000539965, 10332.12176964959, 10446.582136714522, 10450.16398688103, 10454.477276136238, 38397.616023839684, 38490.61509384898, 38575.42136867921, 38594.94753050945, 38638.0, 3292.851821668031, 3306.718928891047, 3331.716804071657, 3584.551931008624, 4020.839166433339, 29111.85444072766, 29467.263318416997, 29476.41047179066, 29797.851010745024, 29954.55068173979, 3933.429652700371, 3959.227950549644, 4047.615476529725, 4103.076807718269, 4187.183499217624, 271468.0, 272421.999999998, 272761.0, 274036.0, 274686.0, 53013.0, 58783.70608146932, 59276.70361648164, 59294.0, 59411.70294148588, 50612.0, 65837.0, 66950.33049669441, 67018.66490667613, 67098.66450667813, 15885.523434296989, 15979.440719574759, 16036.0, 16092.597685057734, 16119.597010074842, 12257.325847078318, 12355.75288494243, 12356.25862448238, 12359.38203089842, 12381.195222310522, 20001.499962501053, 20610.896945515477, 20766.1693532257, 20779.68830467544, 20822.0, 8068.878966815502, 8112.675492980333, 8116.715914942949, 8250.752477425687, 8288.627011784483, 894.2130924786277, 896.0, 955.9733365265681, 1059.0838924330399, 1089.145021158387, 28173.154805355873, 28196.0, 28254.717452825207, 28412.710243223934, 28605.57091643627, 987.09680642213, 992.6079198716467, 1019.23557332001, 1050.8056009638242, 1060.183658582887, 14714.0, 14745.483908063166, 14819.259037048105, 14983.850161498463, 15013.399464021317, 376474.0, 381118.0, 381231.0, 382269.0, 382545.0, 51635.48364516382, 52522.47477525252, 52937.2059419109, 52947.73526132345, 52985.2052219217, 1358.660334916271, 1366.180291824917, 1376.4150236149596, 1381.8825399840925, 1383.5918404070824, 26794.0, 27594.5860812092, 27740.30649233785, 27876.58185127184, 28082.0, 42177.0, 42527.3620895693, 46640.30039549477, 47360.526394735614, 52393.214101787744, 270945.0, 271387.0, 273087.0, 273303.0, 273990.0, 31990.200244994063, 32358.676413235567, 32363.0, 32387.19032024218, 32388.514172287905, 33075.188608967546, 37204.0, 37800.62199377971, 41517.79241103775, 43991.78004110087, 32797.016089517354, 32908.83545582352, 33430.0, 33788.83105584457, 33840.49239261462, 35082.180424628306, 36157.45763813597, 36208.09479763027, 36352.27295454023, 36874.631253688196, 34235.4864677035, 34271.48592771061, 34512.82743586266, 34777.65222347744, 34817.30365392729, 30572.388552229277, 31857.0, 31951.36097278088, 32193.839030804695, 32368.83815580907, 24440.0, 24747.87626061858, 24771.752282476944, 24851.25446236616, 25199.496010080064], "unit": "ms", "name": "ext.html", "value": 18857.351486527758}, {"lowerIsBetter": false, "replicates": [359.72840505418407, 360.5385107062959, 363.4802232807086, 365.2749292654083, 366.90643885809124, 14254.857451425483, 14309.14145151289, 16421.917890410547, 16869.493915182535, 17590.120493975315, 10699.251052426333, 11027.558897644085, 16955.83044169561, 17623.559411014732, 17632.294708211655, 4731.101090792738, 4842.854714358575, 4843.418789745236, 4846.030793841228, 4851.078295123915, 3664.486971823947, 3770.4344348347695, 4820.542048505386, 4833.734144622044, 5213.426523082458, 5258.3689957205, 5321.946780532184, 5336.252924590561, 5337.973310133463, 5344.5724342052545, 5006.224035274557, 5126.871828204287, 5129.281900533928, 5287.206918962148, 5304.92042619361, 4860.687614344142, 4948.505149485059, 4956.1822299320565, 4974.303597496353, 4979.502049794992, 12313.322767247888, 12566.120371573994, 12581.559645412459, 12583.874161258362, 15455.381784728597, 2024.9696254556193, 2029.7767245602972, 2061.5258490547108, 2209.767974362701, 2276.5560715660454, 9304.953475232649, 10366.844497332546, 11869.228500147463, 12904.16122952005, 13665.590032299047, 1793.1303317890813, 1831.6977698679702, 1864.4779461750732, 1872.8782629129064, 1931.1406424141262, 61389.69305153446, 62521.37478625201, 64670.0, 64950.0, 65934.67032664854, 9848.852267215998, 10087.394756314645, 10348.844767328495, 10383.37699738003, 10394.428306443218, 13567.86432135666, 13581.796273055912, 13589.728205436033, 13657.795133073012, 13666.93166534161, 7519.135299440634, 7551.433642476836, 7897.486663366863, 7991.68033278674, 8047.557384343917, 7883.093444253869, 7901.407394445439, 7912.762617121495, 7940.841183176304, 7949.6025198739835, 4234.894127646833, 4302.698811083194, 4399.73601583906, 4431.512533621299, 4436.778161091933, 1649.089357284394, 1673.3892129372691, 1706.0, 1759.551314414816, 2925.4880395931054, 866.2333834556463, 867.0462491259564, 910.5947853205261, 1043.3983834813525, 1051.2496693006212, 16020.519384418487, 16035.518934431986, 16767.916160419365, 16792.244349004322, 17244.913775431043, 816.9078160078291, 845.602566793606, 865.2602025268305, 874.2394117118021, 1014.1775855805744, 9510.762230944143, 9662.420254784736, 9696.51517424126, 9700.27247956392, 9869.802603947881, 549203.0, 553847.0, 554154.0, 562032.0, 562845.0, 76150.61924690341, 82054.58972705099, 84483.0, 85789.57105214434, 88039.55980220185, 1145.5532342386475, 1149.0462915779883, 1175.9176857619884, 1195.227033573574, 1202.3687564028955, 15523.84476155224, 15651.921740391224, 15853.286602102702, 15890.205489725698, 15973.281202346156, 36648.45027324539, 37419.6258037427, 37905.43141852819, 38215.22309711286, 38314.23371532498, 47265.0, 48802.0, 49430.50569494259, 49661.75169124131, 49912.0, 9390.577424015799, 9435.386699864486, 9581.473018984023, 9586.856197157187, 9603.663871764455, 11092.833607495733, 13129.868701313248, 17858.821411785717, 17989.190486428404, 18077.36729214471, 14558.199299038231, 14579.198144101752, 15148.697026059197, 15195.0, 15210.923945380202, 14010.859891401364, 14115.576532704035, 14323.928380358031, 14412.1352718833, 14611.634709132357, 12310.938445307716, 12603.306818124724, 14072.65239209094, 14210.928945355621, 15063.096214227182, 8839.558022098741, 8942.46345219289, 8959.820803584022, 9654.855177172489, 9666.130048295687, 10038.799224015625, 13944.093633913762, 14125.293735312987, 14125.505607303696, 14437.133771973715], "unit": "ms", "name": "jquery.html", "value": 8743.55387256046}, {"lowerIsBetter": false, "replicates": [1325.0790700463183, 1700.532353602759, 1734.8612111031111, 1750.8949463032216, 1765.746320112719, 6817.863642727142, 7347.485676002682, 7456.813579660511, 7459.254074592538, 7468.738594149206, 7615.314621684048, 7753.883691744629, 7757.689692412297, 7762.805929851743, 7767.572783496906, 1963.0, 2003.1786967343392, 2198.076807740753, 2238.753737088919, 2260.6495993121093, 2285.7828506291958, 2287.7369102553253, 2294.265834932822, 2298.908043678259, 2301.2866011536476, 2171.771963943787, 2236.3626366485555, 2237.0827960536185, 2239.0819763896807, 2242.2824696097255, 1945.6400565895283, 1983.841292696588, 2133.381319417375, 2159.179511785527, 2169.5986242545177, 2287.6797248385237, 2291.873946932918, 2311.9422014449606, 2342.2856028911174, 2343.484433424644, 7669.041369828771, 7758.0, 7784.026996625422, 7796.4932279401655, 7823.726169584037, 4799.992001679651, 4866.853994380174, 4904.117258893398, 4908.214685650314, 4909.0, 2939.3092623233524, 3008.0975707287944, 3041.9543706844415, 3042.34589563245, 3053.129857990484, 943.6084025129563, 958.0898146760536, 962.7003545213975, 975.327024353194, 984.867042949207, 10745.194110441747, 10876.293040952312, 10887.401192934465, 10891.455427228608, 10902.61840835575, 4186.581341865789, 4256.87229383119, 4311.547287534827, 4318.1363727254675, 4355.73865568067, 8933.240674542607, 8939.687110951085, 8942.150495702897, 8946.910530894738, 8962.103789620985, 4793.856184314476, 4811.350467686888, 4818.951810481921, 4825.686330388514, 4827.517248275215, 4405.229084910128, 4430.955690443118, 4446.73319600825, 4455.6658250631335, 4457.866264012085, 3518.3315170117594, 3566.554180727409, 3575.4636804479537, 3590.8563657453933, 3603.117236277129, 1063.9308444951052, 1089.5750657243682, 1092.3937214845678, 1119.7144728094283, 1120.42858142348, 1306.758249723804, 1309.7576948264602, 1318.1432069154935, 1332.320516536554, 1352.6618345413647, 6550.8362290943105, 6833.453323734089, 7482.401407887356, 7503.474756766974, 7519.661615227218, 426.45839783474815, 432.35794844655663, 434.03210839827364, 434.30511182108376, 437.47939951457664, 5664.461876121762, 5717.028105222123, 5747.109198074305, 5748.655080695172, 5751.223584815996, 9188.081191880758, 9427.245820334358, 9521.666741664008, 9534.618615255313, 9665.468399238109, 9407.858882116774, 9492.857607135898, 9567.186789123003, 9575.712728618153, 9588.66439674608, 7089.149302083783, 7280.96359518199, 7289.854202916018, 7302.96348518254, 7308.378787803096, 7037.788866334018, 7073.575585464683, 7074.893876591958, 7076.752313668997, 7090.680919358538, 7983.361331093614, 8266.628001740057, 8440.873386899324, 8442.620082096197, 8455.32357411418, 8537.317014638938, 8646.394752367274, 8734.694285700225, 8801.207891289814, 8805.955970220108, 6461.967690161707, 6629.867402652017, 6658.0, 6663.600183988976, 6674.399304062657, 7630.694772209049, 7686.923130768844, 7700.383969282556, 7703.3067023968115, 7704.614769261402, 7074.575525468488, 7244.384227340735, 7303.196648368569, 7359.632018399166, 7393.001944737607, 6985.545939513915, 7142.142942846892, 7174.42604591621, 7240.637968101679, 7269.563826170447, 7215.098112735908, 7261.564306141649, 7265.382442492447, 7273.0908636420445, 7273.309035641606, 6430.0, 6546.8363290918105, 6601.834954125993, 6610.570312929644, 6611.305812889577, 6643.800685979429, 6711.731530738716, 6733.562318449285, 6753.020811982334, 6755.594664320157], "unit": "ms", "name": "mootools.html", "value": 4382.5826675195485}, {"lowerIsBetter": false, "replicates": [306.1977618639165, 312.45788556853853, 318.361684821932, 323.5906578178603, 331.99902294581824, 5992.520598352132, 6165.4142856428625, 6178.814635560929, 6186.56694031418, 6212.099245609384, 5951.404859514047, 5998.010328295826, 6032.69836508175, 6045.727942242599, 6053.424924632164, 4440.755758433284, 4537.2740361542155, 4543.909121817562, 4645.558671926162, 4657.953420465794, 4612.123696497655, 4628.0, 4631.861044168663, 4645.163870503308, 4660.743659098748, 4587.977060114695, 4600.378948841897, 4600.516945720701, 4606.838760643378, 4608.1705293047235, 4404.66964977628, 4487.349334346534, 4524.389207456984, 4567.2692369221095, 4590.357349971006, 4016.4176194451643, 4027.1140349123148, 4031.314676505001, 4031.7580945143386, 4032.8386864525382, 5700.885982280372, 5712.8857422851725, 5719.885602287973, 5720.8283751487525, 5722.771089156428, 5239.921401178985, 5301.125314323132, 5313.495217954288, 5315.654482458628, 5323.0152421802095, 6401.519886008568, 6402.48780097591, 6409.743610255584, 6412.743490260384, 6422.807315780534, 4469.932951005738, 4473.507914129443, 4477.597016268519, 4477.888052798674, 4483.730976141442, 6577.144971153767, 6643.5017373697165, 6657.034729964128, 6661.9000714989315, 6666.666666666647, 4476.798544065525, 4560.95439045612, 4564.406627138451, 4573.56551127649, 4575.3823233863, 4606.078784243165, 4612.169809434267, 4621.214393553104, 4622.86131416058, 4626.976865115653, 5332.973335133377, 5347.0909945309395, 5348.304720386325, 5350.5987050971335, 5352.384475785257, 6434.871302573923, 6438.967805161038, 6440.194975628046, 6446.742130314735, 6452.354534640775, 1598.9120598367201, 1633.093633033654, 1636.9345226191058, 1637.1159573830237, 1637.909914954665, 1077.6066735641434, 1098.1653943003375, 1103.6137351926923, 1105.7512059786484, 1117.0728295514702, 6107.053406721965, 6133.570650054543, 6139.539534534928, 6142.832861756341, 6154.79981403622, 6548.934510654928, 6565.212174539086, 6570.178727659043, 6576.736930522821, 6580.605163690194, 6030.638161710312, 6135.815925522242, 6143.109249158936, 6154.630722156685, 6159.076138579249, 3549.432090865449, 3570.285942811396, 3577.141486043331, 3580.872025312018, 3581.874634387836, 6646.26891041985, 6649.534532582673, 6650.73397064112, 6656.668666266766, 6675.732970681119, 6654.3345665434035, 6664.533482656265, 6735.562188457735, 6738.764143254963, 6748.122744043243, 6730.091437655854, 6920.411765000032, 6944.548604340803, 6945.0, 6951.93048069523, 6684.16447944007, 6702.262751097278, 6703.195616526048, 6704.0, 6712.060311556484, 6428.228612566522, 6514.185726784152, 6581.736730530725, 6621.33786621334, 6627.536072474881, 6904.13698287714, 6905.998630198694, 6910.0, 6921.584704917721, 6942.444604431735, 4405.0, 4426.800793964344, 4428.446444194476, 4430.113977204507, 4432.800523976364, 6583.958972718281, 6653.600783952978, 6667.099941507834, 6668.399844014062, 6674.766383176566, 6338.461230795434, 6435.292117866938, 6466.41802237782, 6504.73981040772, 6510.121133646897, 6479.416852483299, 6490.318516555693, 6497.707603157774, 6499.772507962199, 6500.674966251763, 6227.782027629011, 6377.649229292433, 6384.648844313608, 6395.488360931021, 6397.232332120176, 6532.314107018695, 6534.117894084237, 6534.1178940844275, 6539.149910511603, 6540.476761858945, 6387.680615969276, 6389.201349831271, 6389.87220255583, 6394.360563943755, 6395.328490508429], "unit": "ms", "name": "prototype.html", "value": 4831.27685564631}, {"lowerIsBetter": false, "replicates": [821.6425854753181, 822.6051495282264, 835.1106072033288, 836.7866991806671, 851.81260122773, 14112.15327080376, 14412.423503059892, 14434.711305773879, 14460.276986150677, 14482.855171448282, 13161.539346122887, 14591.270436478188, 14960.251987400614, 14991.550253492385, 15009.399624015026, 689.1523426185795, 824.3734761581211, 836.6109758962082, 836.7573403712946, 837.6858677995751, 688.717625773433, 821.2854816309818, 826.3430572694722, 834.0491839303199, 834.8288600836844, 863.9006514250848, 876.4741155306829, 877.32007694037, 877.5963056993791, 878.8945326560822, 716.3731734732136, 719.3022767915166, 850.5237067242302, 865.5758678247677, 866.1468453573225, 627.9215098112736, 628.2555172121006, 629.6348118091496, 630.4168644004278, 630.5838146823121, 13664.726705465935, 14045.297735113305, 14051.086679365808, 14081.084729492653, 14105.36525856339, 11845.940770296093, 11919.821202681967, 12179.634610961686, 12809.935950320189, 12866.228026318357, 10254.846177307347, 10297.330673506198, 10370.533326000348, 10715.46422678863, 10858.891411085946, 3592.9749296152163, 3642.7267954903486, 3665.4135338345736, 3670.2659468106485, 3762.5108735864437, 46476.0, 47271.0, 47564.28653570199, 47633.523664763256, 47703.76148119272, 9751.17115045215, 9952.253580981456, 10038.598456061676, 10144.188464922789, 10201.693949181536, 17725.379611713528, 18220.08899555017, 18256.81743182551, 18266.0, 18315.358962436516, 7320.377767889789, 7404.111506619241, 7416.147143078507, 7433.2566743326315, 7789.221077892165, 4034.0923292259595, 4163.646090082377, 4171.770552619574, 4173.24881521323, 4179.644730197967, 3067.8619462124257, 3081.4145312390574, 3082.321889184376, 3082.969170308313, 3090.5209692497697, 534.8448949804591, 551.1842473139776, 556.4852511426914, 562.7917670461956, 562.9971850140723, 493.8666560028772, 540.713421886393, 627.9434850863444, 640.5772190354344, 674.6828990374614, 7508.774736757797, 7706.499077559941, 7748.7675369739, 7767.53394796314, 7772.961135194401, 569.6297406685604, 621.0683974038942, 637.9078213261965, 679.3274658088457, 679.653376777837, 3517.8065206413894, 3717.386631205875, 3718.4422336649177, 3844.154286057063, 3866.033491627093, 58446.41553584495, 58931.0, 59005.40994590085, 59282.11076833851, 59342.0, 54236.728816355666, 54702.72648636731, 54772.0, 55370.72314638401, 55851.0, 47548.5245147551, 47692.7615361921, 47906.760466198146, 48466.75766621215, 48640.75679621579, 8145.79635509117, 8324.25081742646, 8424.747257582283, 8437.451565648213, 8544.957275213585, 34420.65579344275, 34789.65210347864, 35127.29745405026, 35266.82366588151, 35429.46855797217, 42799.7860010698, 45867.0, 47382.05235895332, 47608.0, 48025.519744802106, 10685.732856678645, 10990.725231869268, 11014.296253464425, 11084.757586327043, 11325.660230193107, 11822.172447928906, 12101.339805344642, 12233.0, 12331.876681233072, 12410.937945310216, 10310.123639490428, 10619.0, 10651.254412191382, 10776.29954052984, 10845.511951962022, 11514.88485115138, 11756.529738810352, 12115.15193936416, 12262.938685306517, 12608.810867836806, 9973.551190196604, 10346.534405951901, 10357.9482102589, 10533.473326333806, 10642.627508037182, 10008.499575021366, 10222.335548189343, 10398.740031499274, 10562.0, 10644.201684873511, 8942.910570894208, 8969.865452018355, 9001.144891235323, 9373.578188981375, 9449.338546301693], "unit": "ms", "name": "yui.html", "value": 6298.780509998644}], "name": "dromaeo_css", "value": 7014.895455723852}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [107.0, 109.0, 102.0, 110.0, 110.0, 110.0, 98.0, 108.0, 108.0, 99.0], "unit": "ms", "name": "ai-astar", "value": 106.1}, {"lowerIsBetter": true, "replicates": [159.0, 123.0, 154.0, 163.0, 125.0, 149.0, 149.0, 122.0, 170.0, 122.0], "unit": "ms", "name": "audio-beat-detection", "value": 143.6}, {"lowerIsBetter": true, "replicates": [161.0, 160.0, 162.0, 160.0, 160.0, 160.0, 160.0, 162.0, 161.0, 162.0], "unit": "ms", "name": "audio-dft", "value": 160.8}, {"lowerIsBetter": true, "replicates": [72.0, 71.0, 81.0, 93.0, 71.0, 73.0, 71.0, 116.0, 95.0, 71.0], "unit": "ms", "name": "audio-fft", "value": 81.4}, {"lowerIsBetter": true, "replicates": [93.0, 94.0, 145.0, 94.0, 94.0, 94.0, 134.0, 94.0, 94.0, 137.0], "unit": "ms", "name": "audio-oscillator", "value": 107.3}, {"lowerIsBetter": true, "replicates": [109.0, 109.0, 110.0, 111.0, 109.0, 110.0, 109.0, 109.0, 109.0, 109.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 109.4}, {"lowerIsBetter": true, "replicates": [147.0, 146.0, 147.0, 145.0, 146.0, 147.0, 146.0, 145.0, 146.0, 145.0], "unit": "ms", "name": "imaging-darkroom", "value": 146.0}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 95.0, 96.0, 96.0, 96.0, 97.0, 96.0, 96.0, 95.0], "unit": "ms", "name": "imaging-desaturate", "value": 95.9}, {"lowerIsBetter": true, "replicates": [62.0, 62.0, 62.0, 63.0, 63.0, 62.0, 65.0, 62.0, 64.0, 60.0], "unit": "ms", "name": "json-parse-financial", "value": 62.5}, {"lowerIsBetter": true, "replicates": [68.0, 68.0, 68.0, 68.0, 68.0, 69.0, 83.0, 68.0, 69.0, 69.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 69.8}, {"lowerIsBetter": true, "replicates": [84.0, 83.0, 83.0, 84.0, 84.0, 92.0, 84.0, 85.0, 85.0, 85.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 84.9}, {"lowerIsBetter": true, "replicates": [130.0, 120.0, 112.0, 111.0, 140.0, 114.0, 122.0, 118.0, 124.0, 116.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 120.7}, {"lowerIsBetter": true, "replicates": [139.0, 146.0, 158.0, 148.0, 152.0, 137.0, 149.0, 152.0, 152.0, 143.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 147.6}, {"lowerIsBetter": true, "replicates": [65.0, 65.0, 66.0, 67.0, 68.0, 67.0, 66.0, 66.0, 66.0, 65.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 66.1}], "name": "kraken", "value": 1502.1}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [190.22256039566292], "unit": "score", "name": "Richards", "value": 185.5826140000001}, {"lowerIsBetter": false, "replicates": [194.43904335990666], "unit": "score", "name": "DeltaBlue", "value": 340.0448739999999}, {"lowerIsBetter": false, "replicates": [287.93550244745177], "unit": "score", "name": "Encrypt", "value": 924.4466130000002}, {"lowerIsBetter": false, "replicates": [5010.0], "unit": "score", "name": "Decrypt", "value": 53.12994011976049}, {"lowerIsBetter": false, "replicates": [1974.3589743589744], "unit": "score", "name": "RayTrace", "value": 374.7996233766234}, {"lowerIsBetter": false, "replicates": [758.1501137225171], "unit": "score", "name": "Earley", "value": 879.0646969999996}, {"lowerIsBetter": false, "replicates": [12231.707317073171], "unit": "score", "name": "Boyer", "value": 54.4865064805583}, {"lowerIsBetter": false, "replicates": [25175.0], "unit": "score", "name": "RegExp", "value": 36.186097318768596}, {"lowerIsBetter": false, "replicates": [647.2491909385113], "unit": "score", "name": "Splay", "value": 125.90359500000004}, {"lowerIsBetter": false, "replicates": [4850.241545893719], "unit": "score", "name": "NavierStokes", "value": 305.9641434262948}], "name": "v8_7", "value": 19524.889107485393}]} 07:12:19 INFO - RETURN: dromaeo_css: 7014.90 07:12:19 INFO - RETURN: kraken: 1502.10 07:12:19 INFO - RETURN: v8_7: 19524.89 07:12:19 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,201,35]]", "result": "19524.89"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,201,35]]", "result": "1502.10"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,201,35]]", "result": "7014.90"}}} 07:12:19 INFO - Return code: 0 07:12:19 INFO - # TBPL SUCCESS # 07:12:19 INFO - Running post-action listener: _resource_record_post_action 07:12:19 INFO - Running post-run listener: _resource_record_post_run 07:12:20 INFO - Total resource usage - Wall time: 1225s; CPU: 13.0%; Read bytes: 4096; Write bytes: 508432384; Read time: 12; Write time: 540268 07:12:20 INFO - install - Wall time: 15s; CPU: 16.0%; Read bytes: 0; Write bytes: 238174208; Read time: 0; Write time: 384740 07:12:20 INFO - run-tests - Wall time: 1211s; CPU: 13.0%; Read bytes: 4096; Write bytes: 270249984; Read time: 12; Write time: 155528 07:12:20 INFO - Running post-run listener: _upload_blobber_files 07:12:20 INFO - Blob upload gear active. 07:12:20 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 07:12:20 INFO - Copying logs to upload dir... 07:12:20 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1255.452713 ========= master_lag: 0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 55 secs) (at 2015-11-24 07:12:19.702820) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-24 07:12:19.706772) ========= 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=edca6ca23558fe0608d91a4e00000196-1448376508.945868-1650807499 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/kTOGwxGGS5axXPoYVkQs6Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.010154 build_url: 'https://queue.taskcluster.net/v1/task/kTOGwxGGS5axXPoYVkQs6Q/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-24 07:12:19.758552) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-24 07:12:19.758869) ========= 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=edca6ca23558fe0608d91a4e00000196-1448376508.945868-1650807499 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004541 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-24 07:12:19.808143) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-24 07:12:19.808482) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-24 07:12:19.808780) ========= ========= Total master_lag: 0.40 =========