builder: b2g-inbound_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-037 starttime: 1448290624.23 results: success (0) buildid: 20151123053006 builduid: cf05e6c7e76f478797920451b81a9692 revision: 4fc73ccc88ab992a6dc08962dab88261df1070b0 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-11-23 06:57:04.232244) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-11-23 06:57:04.232704) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-23 06:57:04.233011) ========= 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=6ea65ccfe4e6b94e0d4f826f000001d8-1448290565.608392-1842730875 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006635 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.01 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-23 06:57:04.254036) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-23 06:57:04.254310) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-23 06:57:04.268016) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 06:57:04.268268) ========= 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=6ea65ccfe4e6b94e0d4f826f000001d8-1448290565.608392-1842730875 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004635 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 06:57:04.317795) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-23 06:57:04.319728) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-23 06:57:04.320147) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 06:57:04.320592) ========= 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=6ea65ccfe4e6b94e0d4f826f000001d8-1448290565.608392-1842730875 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-11-23 06:57:05-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 43.1M=0s 2015-11-23 06:57:05 (43.1 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.105828 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 06:57:04.440214) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 06:57:04.440705) ========= 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=6ea65ccfe4e6b94e0d4f826f000001d8-1448290565.608392-1842730875 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.022317 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 06:57:04.495036) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 06:57:04.495587) ========= bash -c 'python archiver_client.py mozharness --repo integration/b2g-inbound --rev 4fc73ccc88ab992a6dc08962dab88261df1070b0 --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 4fc73ccc88ab992a6dc08962dab88261df1070b0 --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=6ea65ccfe4e6b94e0d4f826f000001d8-1448290565.608392-1842730875 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-11-23 06:57:05,835 truncating revision to first 12 chars 2015-11-23 06:57:05,835 Setting DEBUG logging. 2015-11-23 06:57:05,835 attempt 1/10 2015-11-23 06:57:05,836 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/b2g-inbound/4fc73ccc88ab?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-11-23 06:57:06,089 unpacking tar archive at: b2g-inbound-4fc73ccc88ab/testing/mozharness/ program finished with exit code 0 elapsedTime=0.544769 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 06:57:05.054544) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-23 06:57:05.054832) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-23 06:57:05.064281) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-23 06:57:05.064532) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-23 06:57:05.064897) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 55 secs) (at 2015-11-23 06:57:05.065179) ========= /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=6ea65ccfe4e6b94e0d4f826f000001d8-1448290565.608392-1842730875 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 06:57:06 INFO - MultiFileLogger online at 20151123 06:57:06 in /builds/slave/test-pgo 06:57:06 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:57:06 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 06:57:06 INFO - {'append_to_log': False, 06:57:06 INFO - 'base_work_dir': '/builds/slave/test-pgo', 06:57:06 INFO - 'blob_upload_branch': 'B2G-Inbound', 06:57:06 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 06:57:06 INFO - 'branch': 'B2G-Inbound', 06:57:06 INFO - 'buildbot_json_path': 'buildprops.json', 06:57:06 INFO - 'config_files': ('talos/linux_config.py',), 06:57:06 INFO - 'default_actions': ('clobber', 06:57:06 INFO - 'read-buildbot-config', 06:57:06 INFO - 'download-and-extract', 06:57:06 INFO - 'populate-webroot', 06:57:06 INFO - 'create-virtualenv', 06:57:06 INFO - 'install', 06:57:06 INFO - 'run-tests'), 06:57:06 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 06:57:06 INFO - 'download_minidump_stackwalk': True, 06:57:06 INFO - 'download_symbols': 'ondemand', 06:57:06 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 06:57:06 INFO - 'tooltool.py': '/tools/tooltool.py', 06:57:06 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 06:57:06 INFO - '/tools/misc-python/virtualenv.py')}, 06:57:06 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 06:57:06 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 06:57:06 INFO - 'installer_path': 'installer.exe', 06:57:06 INFO - 'log_level': 'info', 06:57:06 INFO - 'log_name': 'talos', 06:57:06 INFO - 'log_to_console': True, 06:57:06 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 06:57:06 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 06:57:06 INFO - 'opt_config_files': (), 06:57:06 INFO - 'pip_index': False, 06:57:06 INFO - 'sps_profile': False, 06:57:06 INFO - 'sps_profile_interval': 0, 06:57:06 INFO - 'suite': 'dromaeojs', 06:57:06 INFO - 'system_bits': '64', 06:57:06 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 06:57:06 INFO - 'title': 'talos-linux64-ix-037', 06:57:06 INFO - 'tooltool_cache': '/builds/tooltool_cache', 06:57:06 INFO - 'use_talos_json': True, 06:57:06 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 06:57:06 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 06:57:06 INFO - 'work_dir': 'build'} 06:57:06 INFO - ##### 06:57:06 INFO - ##### Running clobber step. 06:57:06 INFO - ##### 06:57:06 INFO - Running pre-action listener: _resource_record_pre_action 06:57:06 INFO - Running main action method: clobber 06:57:06 INFO - rmtree: /builds/slave/test-pgo/build 06:57:06 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 06:57:06 INFO - Running post-action listener: _resource_record_post_action 06:57:06 INFO - ##### 06:57:06 INFO - ##### Running read-buildbot-config step. 06:57:06 INFO - ##### 06:57:06 INFO - Running pre-action listener: _resource_record_pre_action 06:57:06 INFO - Running main action method: read_buildbot_config 06:57:06 INFO - Using buildbot properties: 06:57:06 INFO - { 06:57:06 INFO - "properties": { 06:57:06 INFO - "buildnumber": 113, 06:57:06 INFO - "product": "firefox", 06:57:06 INFO - "script_repo_revision": "production", 06:57:06 INFO - "builddir": "b2g-inbound_ubuntu64_hw_test-dromaeojs", 06:57:06 INFO - "repository": "", 06:57:06 INFO - "buildername": "Ubuntu HW 12.04 x64 b2g-inbound pgo talos dromaeojs", 06:57:06 INFO - "buildid": "20151123053006", 06:57:06 INFO - "slavename": "talos-linux64-ix-037", 06:57:06 INFO - "pgo_build": "True", 06:57:06 INFO - "basedir": "/builds/slave/test-pgo", 06:57:06 INFO - "project": "", 06:57:06 INFO - "platform": "ubuntu64_hw", 06:57:06 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 06:57:06 INFO - "slavebuilddir": "test", 06:57:06 INFO - "scheduler": "tests-b2g-inbound-linux64-pgo-talos", 06:57:06 INFO - "branch": "b2g-inbound", 06:57:06 INFO - "repo_path": "integration/b2g-inbound", 06:57:06 INFO - "stage_platform": "linux64-pgo", 06:57:06 INFO - "builduid": "cf05e6c7e76f478797920451b81a9692", 06:57:06 INFO - "revision": "4fc73ccc88ab992a6dc08962dab88261df1070b0" 06:57:06 INFO - }, 06:57:06 INFO - "sourcestamp": { 06:57:06 INFO - "repository": "", 06:57:06 INFO - "hasPatch": false, 06:57:06 INFO - "project": "", 06:57:06 INFO - "branch": "b2g-inbound-linux64-pgo-talos", 06:57:06 INFO - "changes": [ 06:57:06 INFO - { 06:57:06 INFO - "category": null, 06:57:06 INFO - "files": [ 06:57:06 INFO - { 06:57:06 INFO - "url": null, 06:57:06 INFO - "name": "https://queue.taskcluster.net/v1/task/h7cJle0OS72hT2EgK2u93g/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2" 06:57:06 INFO - } 06:57:06 INFO - ], 06:57:06 INFO - "repository": "", 06:57:06 INFO - "rev": "4fc73ccc88ab992a6dc08962dab88261df1070b0", 06:57:06 INFO - "who": "sendchange", 06:57:06 INFO - "when": 1448290564, 06:57:06 INFO - "number": 6695076, 06:57:06 INFO - "comments": "", 06:57:06 INFO - "project": "", 06:57:06 INFO - "at": "Mon 23 Nov 2015 06:56:04", 06:57:06 INFO - "branch": "b2g-inbound-linux64-pgo-talos", 06:57:06 INFO - "revlink": "", 06:57:06 INFO - "properties": [ 06:57:06 INFO - [ 06:57:06 INFO - "buildid", 06:57:06 INFO - "20151123053006", 06:57:06 INFO - "Change" 06:57:06 INFO - ], 06:57:06 INFO - [ 06:57:06 INFO - "builduid", 06:57:06 INFO - "cf05e6c7e76f478797920451b81a9692", 06:57:06 INFO - "Change" 06:57:06 INFO - ], 06:57:06 INFO - [ 06:57:06 INFO - "pgo_build", 06:57:06 INFO - "True", 06:57:06 INFO - "Change" 06:57:06 INFO - ] 06:57:06 INFO - ], 06:57:06 INFO - "revision": "4fc73ccc88ab992a6dc08962dab88261df1070b0" 06:57:06 INFO - } 06:57:06 INFO - ], 06:57:06 INFO - "revision": "4fc73ccc88ab992a6dc08962dab88261df1070b0" 06:57:06 INFO - } 06:57:06 INFO - } 06:57:06 INFO - Found installer url https://queue.taskcluster.net/v1/task/h7cJle0OS72hT2EgK2u93g/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2. 06:57:06 INFO - Running post-action listener: _resource_record_post_action 06:57:06 INFO - ##### 06:57:06 INFO - ##### Running download-and-extract step. 06:57:06 INFO - ##### 06:57:06 INFO - Running pre-action listener: _resource_record_pre_action 06:57:06 INFO - Running main action method: download_and_extract 06:57:06 INFO - mkdir: /builds/slave/test-pgo/build/tests 06:57:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:57:06 INFO - https://queue.taskcluster.net/v1/task/h7cJle0OS72hT2EgK2u93g/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 06:57:06 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/h7cJle0OS72hT2EgK2u93g/artifacts/public/build/test_packages.json 06:57:06 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/h7cJle0OS72hT2EgK2u93g/artifacts/public/build/test_packages.json 06:57:06 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/h7cJle0OS72hT2EgK2u93g/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 06:57:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/h7cJle0OS72hT2EgK2u93g/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 06:57:08 INFO - Downloaded 1302 bytes. 06:57:08 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 06:57:08 INFO - Using the following test package requirements: 06:57:08 INFO - {u'common': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 06:57:08 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 06:57:08 INFO - u'firefox-45.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 06:57:08 INFO - u'jittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 06:57:08 INFO - u'jsshell-linux-x86_64.zip'], 06:57:08 INFO - u'mochitest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 06:57:08 INFO - u'firefox-45.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 06:57:08 INFO - u'mozbase': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 06:57:08 INFO - u'reftest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 06:57:08 INFO - u'firefox-45.0a1.en-US.linux-x86_64.reftest.tests.zip'], 06:57:08 INFO - u'talos': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 06:57:08 INFO - u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'], 06:57:08 INFO - u'web-platform': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 06:57:08 INFO - u'firefox-45.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 06:57:08 INFO - u'webapprt': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 06:57:08 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 06:57:08 INFO - u'firefox-45.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 06:57:08 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 06:57: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:57:08 INFO - https://queue.taskcluster.net/v1/task/h7cJle0OS72hT2EgK2u93g/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 06:57:08 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/h7cJle0OS72hT2EgK2u93g/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 06:57:08 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/h7cJle0OS72hT2EgK2u93g/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 06:57:08 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/h7cJle0OS72hT2EgK2u93g/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:57:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/h7cJle0OS72hT2EgK2u93g/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:57:09 INFO - Downloaded 22524171 bytes. 06:57:09 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:57:09 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 06:57:09 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:57:10 INFO - Return code: 0 06:57:10 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:57:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:57:10 INFO - https://queue.taskcluster.net/v1/task/h7cJle0OS72hT2EgK2u93g/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 06:57:10 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/h7cJle0OS72hT2EgK2u93g/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 06:57:10 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/h7cJle0OS72hT2EgK2u93g/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 06:57:10 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/h7cJle0OS72hT2EgK2u93g/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:57:10 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/h7cJle0OS72hT2EgK2u93g/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:57:11 INFO - Downloaded 22524171 bytes. 06:57:11 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:57:11 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 06:57:11 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:57:12 INFO - Return code: 0 06:57:12 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:57:12 INFO - https://queue.taskcluster.net/v1/task/h7cJle0OS72hT2EgK2u93g/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 06:57:12 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/h7cJle0OS72hT2EgK2u93g/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 06:57:12 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/h7cJle0OS72hT2EgK2u93g/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 06:57:12 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/h7cJle0OS72hT2EgK2u93g/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:57:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/h7cJle0OS72hT2EgK2u93g/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:57:14 INFO - Downloaded 11130997 bytes. 06:57:14 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:57:14 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 06:57:14 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:57:14 INFO - Return code: 0 06:57:14 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:57:14 INFO - https://queue.taskcluster.net/v1/task/h7cJle0OS72hT2EgK2u93g/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 06:57:14 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/h7cJle0OS72hT2EgK2u93g/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 06:57:14 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/h7cJle0OS72hT2EgK2u93g/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 06:57:14 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/h7cJle0OS72hT2EgK2u93g/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:57:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/h7cJle0OS72hT2EgK2u93g/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:57:16 INFO - Downloaded 57435130 bytes. 06:57:16 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/h7cJle0OS72hT2EgK2u93g/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 06:57:16 INFO - mkdir: /builds/slave/test-pgo/properties 06:57:16 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 06:57:16 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 06:57:16 INFO - Contents: 06:57:16 INFO - build_url:https://queue.taskcluster.net/v1/task/h7cJle0OS72hT2EgK2u93g/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 06:57:16 INFO - Running post-action listener: _resource_record_post_action 06:57:16 INFO - Running post-action listener: set_extra_try_arguments 06:57:16 INFO - ##### 06:57:16 INFO - ##### Running populate-webroot step. 06:57:16 INFO - ##### 06:57:16 INFO - Running pre-action listener: _resource_record_pre_action 06:57:16 INFO - Running main action method: populate_webroot 06:57:16 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 06:57:16 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 06:57:16 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 06:57:16 INFO - '../fennec_ids.txt'], 06:57:16 INFO - 'tests': ['tcheck2']}, 06:57:16 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 06:57:16 INFO - '--tppagecycles', 06:57:16 INFO - '7'], 06:57:16 INFO - 'tests': ['tsvgm']}}, 06:57:16 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 06:57:16 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 06:57:16 INFO - 'tests': ['tresize', 'tcanvasmark']}, 06:57:16 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 06:57:16 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 06:57:16 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 06:57:16 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:57:16 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:57:16 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:57:16 INFO - 'talos_options': ['--e10s'], 06:57:16 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:57:16 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:57:16 INFO - 'tests': ['damp', 'tps']}, 06:57:16 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:57:16 INFO - 'talos_options': ['--e10s'], 06:57:16 INFO - 'tests': ['damp', 'tps']}, 06:57:16 INFO - 'g3': {'tests': ['dromaeo_dom']}, 06:57:16 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 06:57:16 INFO - 'other': {'tests': ['a11yr', 06:57:16 INFO - 'ts_paint', 06:57:16 INFO - 'tpaint', 06:57:16 INFO - 'sessionrestore', 06:57:16 INFO - 'sessionrestore_no_auto_restore']}, 06:57:16 INFO - 'other-e10s': {'talos_options': ['--e10s'], 06:57:16 INFO - 'tests': ['a11yr', 06:57:16 INFO - 'ts_paint', 06:57:16 INFO - 'tpaint', 06:57:16 INFO - 'sessionrestore', 06:57:16 INFO - 'sessionrestore_no_auto_restore']}, 06:57:16 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 06:57:16 INFO - 'tests': ['a11yr', 06:57:16 INFO - 'ts_paint', 06:57:16 INFO - 'tpaint', 06:57:16 INFO - 'sessionrestore', 06:57:16 INFO - 'sessionrestore_no_auto_restore']}, 06:57:16 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 06:57:16 INFO - 'tests': ['a11yr', 06:57:16 INFO - 'ts_paint', 06:57:16 INFO - 'tpaint', 06:57:16 INFO - 'sessionrestore', 06:57:16 INFO - 'sessionrestore_no_auto_restore']}, 06:57:16 INFO - 'other_l64': {'tests': ['a11yr', 06:57:16 INFO - 'ts_paint', 06:57:16 INFO - 'tpaint', 06:57:16 INFO - 'sessionrestore', 06:57:16 INFO - 'sessionrestore_no_auto_restore']}, 06:57:16 INFO - 'other_nol64': {'tests': ['a11yr', 06:57:16 INFO - 'ts_paint', 06:57:16 INFO - 'tpaint', 06:57:16 INFO - 'sessionrestore', 06:57:16 INFO - 'sessionrestore_no_auto_restore']}, 06:57:16 INFO - 'svgr': {'tests': ['tsvgx', 06:57:16 INFO - 'tsvgr_opacity', 06:57:16 INFO - 'tart', 06:57:16 INFO - 'tscrollx', 06:57:16 INFO - 'cart']}, 06:57:16 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 06:57:16 INFO - 'tests': ['tsvgx', 06:57:16 INFO - 'tsvgr_opacity', 06:57:16 INFO - 'tart', 06:57:16 INFO - 'tscrollx', 06:57:16 INFO - 'cart']}, 06:57:16 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:57:16 INFO - 'tests': ['tp5o']}, 06:57:16 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:57:16 INFO - 'talos_options': ['--e10s'], 06:57:16 INFO - 'tests': ['tp5o']}, 06:57:16 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:57:16 INFO - 'talos_options': ['--xperf_path', 06:57:16 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:57:16 INFO - 'tests': ['tp5n']}, 06:57:16 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:57:16 INFO - 'talos_options': ['--e10s', 06:57:16 INFO - '--xperf_path', 06:57:16 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:57:16 INFO - 'tests': ['tp5n']}}, 06:57:16 INFO - 'talos.zip': {'path': '', 06:57:16 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 06:57:16 INFO - Running post-action listener: _resource_record_post_action 06:57:16 INFO - ##### 06:57:16 INFO - ##### Running create-virtualenv step. 06:57:16 INFO - ##### 06:57:16 INFO - Running pre-action listener: _resource_record_pre_action 06:57:16 INFO - Running main action method: create_virtualenv 06:57:16 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 06:57:16 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:57:16 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 06:57:16 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 06:57:16 INFO - Using real prefix '/usr' 06:57:16 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 06:57:17 INFO - Installing distribute.............................................................................................................................................................................................done. 06:57:19 INFO - Installing pip.................done. 06:57:19 INFO - Return code: 0 06:57:19 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 06:57:19 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:57:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:57:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:57:19 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:57:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:57:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:57:19 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 0x7ffee1b3ac70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16f06c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17b16e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17e7a90>, '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 0x1839f70>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x183a2e0>, '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': '6ea65ccfe4e6b94e0d4f826f000001d8-1448290565.608392-1842730875', '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:57:19 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:57:19 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:57:19 INFO - Using env: {'DISPLAY': ':0', 06:57:19 INFO - 'HOME': '/home/cltbld', 06:57:19 INFO - 'LANG': 'en_US.UTF-8', 06:57:19 INFO - 'LANGUAGE': 'en_US:en', 06:57:19 INFO - 'LOGNAME': 'cltbld', 06:57:19 INFO - 'MAIL': '/var/mail/cltbld', 06:57:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:57:19 INFO - 'MOZ_NO_REMOTE': '1', 06:57:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:57:19 INFO - 'NO_EM_RESTART': '1', 06:57:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:57:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 06:57:19 INFO - 'PWD': '/builds/slave/test-pgo', 06:57:19 INFO - 'SHELL': '/bin/bash', 06:57:19 INFO - 'SHLVL': '1', 06:57:19 INFO - 'TERM': 'linux', 06:57:19 INFO - 'TMOUT': '86400', 06:57:19 INFO - 'USER': 'cltbld', 06:57:19 INFO - 'XDG_SESSION_COOKIE': '6ea65ccfe4e6b94e0d4f826f000001d8-1448290565.608392-1842730875', 06:57:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:57:19 INFO - '_': '/tools/buildbot/bin/python'} 06:57:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:57:19 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:57:19 INFO - Cleaning up... 06:57:19 INFO - Return code: 0 06:57:19 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 06:57:19 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:57:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:57:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:57:19 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:57:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:57:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:57:19 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 0x7ffee1b3ac70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16f06c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17b16e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17e7a90>, '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 0x1839f70>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x183a2e0>, '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': '6ea65ccfe4e6b94e0d4f826f000001d8-1448290565.608392-1842730875', '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:57:19 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:57:19 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:57:19 INFO - Using env: {'DISPLAY': ':0', 06:57:19 INFO - 'HOME': '/home/cltbld', 06:57:19 INFO - 'LANG': 'en_US.UTF-8', 06:57:19 INFO - 'LANGUAGE': 'en_US:en', 06:57:19 INFO - 'LOGNAME': 'cltbld', 06:57:19 INFO - 'MAIL': '/var/mail/cltbld', 06:57:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:57:19 INFO - 'MOZ_NO_REMOTE': '1', 06:57:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:57:19 INFO - 'NO_EM_RESTART': '1', 06:57:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:57:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 06:57:19 INFO - 'PWD': '/builds/slave/test-pgo', 06:57:19 INFO - 'SHELL': '/bin/bash', 06:57:19 INFO - 'SHLVL': '1', 06:57:19 INFO - 'TERM': 'linux', 06:57:19 INFO - 'TMOUT': '86400', 06:57:19 INFO - 'USER': 'cltbld', 06:57:19 INFO - 'XDG_SESSION_COOKIE': '6ea65ccfe4e6b94e0d4f826f000001d8-1448290565.608392-1842730875', 06:57:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:57:19 INFO - '_': '/tools/buildbot/bin/python'} 06:57:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:57:19 INFO - Downloading/unpacking psutil>=0.7.1 06:57:19 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:57:19 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:57:19 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:57:19 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:57:19 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:57:19 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:57:21 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 06:57:21 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 06:57:21 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 06:57:21 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:57:21 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:57:21 INFO - Installing collected packages: psutil 06:57:21 INFO - Running setup.py install for psutil 06:57:21 INFO - building 'psutil._psutil_linux' extension 06:57:21 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:57:21 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:57:21 INFO - building 'psutil._psutil_posix' extension 06:57:21 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:57:21 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:57:21 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:57:21 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:57:22 INFO - Successfully installed psutil 06:57:22 INFO - Cleaning up... 06:57:22 INFO - Return code: 0 06:57:22 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 06:57:22 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:57:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:57:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:57:22 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:57:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:57:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:57:22 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 0x7ffee1b3ac70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16f06c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17b16e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17e7a90>, '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 0x1839f70>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x183a2e0>, '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': '6ea65ccfe4e6b94e0d4f826f000001d8-1448290565.608392-1842730875', '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:57:22 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:57:22 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:57:22 INFO - Using env: {'DISPLAY': ':0', 06:57:22 INFO - 'HOME': '/home/cltbld', 06:57:22 INFO - 'LANG': 'en_US.UTF-8', 06:57:22 INFO - 'LANGUAGE': 'en_US:en', 06:57:22 INFO - 'LOGNAME': 'cltbld', 06:57:22 INFO - 'MAIL': '/var/mail/cltbld', 06:57:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:57:22 INFO - 'MOZ_NO_REMOTE': '1', 06:57:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:57:22 INFO - 'NO_EM_RESTART': '1', 06:57:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:57:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 06:57:22 INFO - 'PWD': '/builds/slave/test-pgo', 06:57:22 INFO - 'SHELL': '/bin/bash', 06:57:22 INFO - 'SHLVL': '1', 06:57:22 INFO - 'TERM': 'linux', 06:57:22 INFO - 'TMOUT': '86400', 06:57:22 INFO - 'USER': 'cltbld', 06:57:22 INFO - 'XDG_SESSION_COOKIE': '6ea65ccfe4e6b94e0d4f826f000001d8-1448290565.608392-1842730875', 06:57:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:57:22 INFO - '_': '/tools/buildbot/bin/python'} 06:57:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:57:22 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 06:57:22 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:57:22 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:57:22 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:57:22 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:57:22 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:57:22 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:57:23 INFO - Downloading mozsystemmonitor-0.0.tar.gz 06:57:23 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 06:57:23 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 06:57:23 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:57:23 INFO - Installing collected packages: mozsystemmonitor 06:57:23 INFO - Running setup.py install for mozsystemmonitor 06:57:24 INFO - Successfully installed mozsystemmonitor 06:57:24 INFO - Cleaning up... 06:57:24 INFO - Return code: 0 06:57:24 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 06:57:24 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:57:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:57:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:57:24 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:57:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:57:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:57:24 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 0x7ffee1b3ac70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16f06c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17b16e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17e7a90>, '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 0x1839f70>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x183a2e0>, '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': '6ea65ccfe4e6b94e0d4f826f000001d8-1448290565.608392-1842730875', '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:57:24 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:57:24 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:57:24 INFO - Using env: {'DISPLAY': ':0', 06:57:24 INFO - 'HOME': '/home/cltbld', 06:57:24 INFO - 'LANG': 'en_US.UTF-8', 06:57:24 INFO - 'LANGUAGE': 'en_US:en', 06:57:24 INFO - 'LOGNAME': 'cltbld', 06:57:24 INFO - 'MAIL': '/var/mail/cltbld', 06:57:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:57:24 INFO - 'MOZ_NO_REMOTE': '1', 06:57:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:57:24 INFO - 'NO_EM_RESTART': '1', 06:57:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:57:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 06:57:24 INFO - 'PWD': '/builds/slave/test-pgo', 06:57:24 INFO - 'SHELL': '/bin/bash', 06:57:24 INFO - 'SHLVL': '1', 06:57:24 INFO - 'TERM': 'linux', 06:57:24 INFO - 'TMOUT': '86400', 06:57:24 INFO - 'USER': 'cltbld', 06:57:24 INFO - 'XDG_SESSION_COOKIE': '6ea65ccfe4e6b94e0d4f826f000001d8-1448290565.608392-1842730875', 06:57:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:57:24 INFO - '_': '/tools/buildbot/bin/python'} 06:57:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:57:24 INFO - Downloading/unpacking blobuploader==1.2.4 06:57:24 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:57:24 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:57:24 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:57:24 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:57:24 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:57:24 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:57:25 INFO - Downloading blobuploader-1.2.4.tar.gz 06:57:25 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 06:57:25 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 06:57:26 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 06:57:26 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:57:26 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:57:26 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:57:26 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:57:26 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:57:26 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:57:26 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 06:57:26 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 06:57:26 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 06:57:26 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:57:26 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:57:26 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:57:26 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:57:26 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:57:26 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:57:26 INFO - Downloading docopt-0.6.1.tar.gz 06:57:26 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 06:57:26 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 06:57:26 INFO - Installing collected packages: blobuploader, requests, docopt 06:57:26 INFO - Running setup.py install for blobuploader 06:57:26 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 06:57:26 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 06:57:26 INFO - Running setup.py install for requests 06:57:27 INFO - Running setup.py install for docopt 06:57:27 INFO - Successfully installed blobuploader requests docopt 06:57:27 INFO - Cleaning up... 06:57:27 INFO - Return code: 0 06:57:27 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 06:57:27 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:57:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:57:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:57:27 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:57:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:57:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:57:27 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 0x7ffee1b3ac70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16f06c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17b16e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17e7a90>, '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 0x1839f70>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x183a2e0>, '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': '6ea65ccfe4e6b94e0d4f826f000001d8-1448290565.608392-1842730875', '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:57:27 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:57:27 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:57:27 INFO - Using env: {'DISPLAY': ':0', 06:57:27 INFO - 'HOME': '/home/cltbld', 06:57:27 INFO - 'LANG': 'en_US.UTF-8', 06:57:27 INFO - 'LANGUAGE': 'en_US:en', 06:57:27 INFO - 'LOGNAME': 'cltbld', 06:57:27 INFO - 'MAIL': '/var/mail/cltbld', 06:57:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:57:27 INFO - 'MOZ_NO_REMOTE': '1', 06:57:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:57:27 INFO - 'NO_EM_RESTART': '1', 06:57:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:57:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 06:57:27 INFO - 'PWD': '/builds/slave/test-pgo', 06:57:27 INFO - 'SHELL': '/bin/bash', 06:57:27 INFO - 'SHLVL': '1', 06:57:27 INFO - 'TERM': 'linux', 06:57:27 INFO - 'TMOUT': '86400', 06:57:27 INFO - 'USER': 'cltbld', 06:57:27 INFO - 'XDG_SESSION_COOKIE': '6ea65ccfe4e6b94e0d4f826f000001d8-1448290565.608392-1842730875', 06:57:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:57:27 INFO - '_': '/tools/buildbot/bin/python'} 06:57:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:57:27 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 06:57:27 INFO - Running setup.py (path:/tmp/pip-W_Vfbu-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 06:57:27 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 06:57:27 INFO - Running setup.py (path:/tmp/pip-LIK6JE-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 06:57:27 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 06:57:27 INFO - Running setup.py (path:/tmp/pip-V1IfHC-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 06:57:27 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 06:57:27 INFO - Running setup.py (path:/tmp/pip-Tu9sWY-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 06:57:27 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 06:57:27 INFO - Running setup.py (path:/tmp/pip-evxwHW-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 06:57:27 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 06:57:27 INFO - Running setup.py (path:/tmp/pip-5oVmhv-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 06:57:27 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 06:57:27 INFO - Running setup.py (path:/tmp/pip-ta76QV-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 06:57:28 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 06:57:28 INFO - Running setup.py (path:/tmp/pip-An_Rss-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 06:57:28 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 06:57:28 INFO - Running setup.py (path:/tmp/pip-Ft6Edn-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 06:57:28 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 06:57:28 INFO - Running setup.py (path:/tmp/pip-EqUzJP-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 06:57:28 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 06:57:28 INFO - Running setup.py (path:/tmp/pip-2LT4TC-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 06:57:28 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 06:57:28 INFO - Running setup.py (path:/tmp/pip-r6ieZ1-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 06:57:28 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 06:57:28 INFO - Running setup.py (path:/tmp/pip-wyHHst-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 06:57:28 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 06:57:28 INFO - Running setup.py (path:/tmp/pip-qwIDeV-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 06:57:28 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 06:57:28 INFO - Running setup.py (path:/tmp/pip-uQHk6H-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 06:57:28 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 06:57:28 INFO - Running setup.py (path:/tmp/pip-CW71dP-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 06:57:28 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 06:57:28 INFO - Running setup.py (path:/tmp/pip-IYgKTM-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 06:57:28 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 06:57:28 INFO - Running setup.py install for manifestparser 06:57:28 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 06:57:28 INFO - Running setup.py install for mozcrash 06:57:28 INFO - Running setup.py install for mozdebug 06:57:29 INFO - Running setup.py install for mozdevice 06:57:29 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 06:57:29 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 06:57:29 INFO - Running setup.py install for mozfile 06:57:29 INFO - Running setup.py install for mozhttpd 06:57:29 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 06:57:29 INFO - Running setup.py install for mozinfo 06:57:29 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 06:57:29 INFO - Running setup.py install for mozInstall 06:57:29 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 06:57:29 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 06:57:29 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 06:57:29 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 06:57:29 INFO - Running setup.py install for mozleak 06:57:29 INFO - Running setup.py install for mozlog 06:57:29 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 06:57:29 INFO - Running setup.py install for moznetwork 06:57:29 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 06:57:29 INFO - Running setup.py install for mozprocess 06:57:29 INFO - Running setup.py install for mozprofile 06:57:30 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 06:57:30 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 06:57:30 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 06:57:30 INFO - Running setup.py install for mozrunner 06:57:30 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 06:57:30 INFO - Running setup.py install for mozscreenshot 06:57:30 INFO - Running setup.py install for moztest 06:57:30 INFO - Running setup.py install for mozversion 06:57:30 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 06:57:30 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 06:57:30 INFO - Cleaning up... 06:57:30 INFO - Return code: 0 06:57:30 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 06:57: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:57:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:57:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:57: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:57:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:57:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:57:30 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 0x7ffee1b3ac70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16f06c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17b16e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17e7a90>, '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 0x1839f70>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x183a2e0>, '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': '6ea65ccfe4e6b94e0d4f826f000001d8-1448290565.608392-1842730875', '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:57:30 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:57:30 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:57:30 INFO - Using env: {'DISPLAY': ':0', 06:57:30 INFO - 'HOME': '/home/cltbld', 06:57:30 INFO - 'LANG': 'en_US.UTF-8', 06:57:30 INFO - 'LANGUAGE': 'en_US:en', 06:57:30 INFO - 'LOGNAME': 'cltbld', 06:57:30 INFO - 'MAIL': '/var/mail/cltbld', 06:57:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:57:30 INFO - 'MOZ_NO_REMOTE': '1', 06:57:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:57:30 INFO - 'NO_EM_RESTART': '1', 06:57:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:57:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 06:57:30 INFO - 'PWD': '/builds/slave/test-pgo', 06:57:30 INFO - 'SHELL': '/bin/bash', 06:57:30 INFO - 'SHLVL': '1', 06:57:30 INFO - 'TERM': 'linux', 06:57:30 INFO - 'TMOUT': '86400', 06:57:30 INFO - 'USER': 'cltbld', 06:57:30 INFO - 'XDG_SESSION_COOKIE': '6ea65ccfe4e6b94e0d4f826f000001d8-1448290565.608392-1842730875', 06:57:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:57:30 INFO - '_': '/tools/buildbot/bin/python'} 06:57:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:57:30 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 06:57:30 INFO - Running setup.py (path:/tmp/pip-4NsolE-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 06:57:30 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:57:30 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 06:57:30 INFO - Running setup.py (path:/tmp/pip-C22W4Q-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 06:57:30 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:57:30 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 06:57:30 INFO - Running setup.py (path:/tmp/pip-Gw63YC-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 06:57:30 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:57:30 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 06:57:30 INFO - Running setup.py (path:/tmp/pip-cydPAN-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 06:57:31 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:57:31 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 06:57:31 INFO - Running setup.py (path:/tmp/pip-Gcuyh9-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 06:57:31 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:57:31 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 06:57:31 INFO - Running setup.py (path:/tmp/pip-qz8muU-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 06:57:31 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:57:31 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 06:57:31 INFO - Running setup.py (path:/tmp/pip-LzUPu0-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 06:57:31 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:57:31 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 06:57:31 INFO - Running setup.py (path:/tmp/pip-FvahO9-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 06:57:31 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:57:31 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 06:57:31 INFO - Running setup.py (path:/tmp/pip-Cx_GXz-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 06:57:31 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:57:31 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 06:57:31 INFO - Running setup.py (path:/tmp/pip-t3HPsS-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 06:57:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.0 from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 06:57:31 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 06:57:31 INFO - Running setup.py (path:/tmp/pip-iuS45I-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 06:57:31 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:57:31 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 06:57:31 INFO - Running setup.py (path:/tmp/pip-XilQLQ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 06:57:31 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:57:31 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 06:57:31 INFO - Running setup.py (path:/tmp/pip-d_012k-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 06:57:31 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:57:31 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 06:57:31 INFO - Running setup.py (path:/tmp/pip-SvQhOX-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 06:57:31 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:57:31 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 06:57:31 INFO - Running setup.py (path:/tmp/pip-HvTmtW-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 06:57:31 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:57:31 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 06:57:31 INFO - Running setup.py (path:/tmp/pip-517bmL-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 06:57:31 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:57:31 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 06:57:31 INFO - Running setup.py (path:/tmp/pip-6b8VNx-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 06:57:31 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:57:31 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:57:31 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:57:31 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:57:31 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:57:31 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:57:32 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.0->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 06:57:32 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:57:32 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:57:32 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:57:32 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:57:32 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:57:32 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:57:33 INFO - Downloading blessings-1.5.1.tar.gz 06:57:33 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:57:33 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 06:57:33 INFO - Installing collected packages: blessings 06:57:33 INFO - Running setup.py install for blessings 06:57:33 INFO - Successfully installed blessings 06:57:33 INFO - Cleaning up... 06:57:33 INFO - Return code: 0 06:57:33 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 06:57:33 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 06:57:33 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 06:57:34 INFO - Reading from file tmpfile_stdout 06:57:34 INFO - Current package versions: 06:57:34 INFO - argparse == 1.2.1 06:57:34 INFO - blessings == 1.5.1 06:57:34 INFO - blobuploader == 1.2.4 06:57:34 INFO - docopt == 0.6.1 06:57:34 INFO - manifestparser == 1.1 06:57:34 INFO - mozInstall == 1.12 06:57:34 INFO - mozcrash == 0.16 06:57:34 INFO - mozdebug == 0.1 06:57:34 INFO - mozdevice == 0.47 06:57:34 INFO - mozfile == 1.2 06:57:34 INFO - mozhttpd == 0.7 06:57:34 INFO - mozinfo == 0.9 06:57:34 INFO - mozleak == 0.1 06:57:34 INFO - mozlog == 3.0 06:57:34 INFO - moznetwork == 0.27 06:57:34 INFO - mozprocess == 0.22 06:57:34 INFO - mozprofile == 0.27 06:57:34 INFO - mozrunner == 6.11 06:57:34 INFO - mozscreenshot == 0.1 06:57:34 INFO - mozsystemmonitor == 0.0 06:57:34 INFO - moztest == 0.7 06:57:34 INFO - mozversion == 1.4 06:57:34 INFO - psutil == 3.1.1 06:57:34 INFO - requests == 1.2.3 06:57:34 INFO - wsgiref == 0.1.2 06:57:34 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 06:57: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:57:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:57:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:57: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:57:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:57:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:57:34 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 0x7ffee1b3ac70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16f06c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17b16e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17e7a90>, '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 0x1839f70>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x183a2e0>, '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': '6ea65ccfe4e6b94e0d4f826f000001d8-1448290565.608392-1842730875', '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:57:34 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:57:34 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:57:34 INFO - Using env: {'DISPLAY': ':0', 06:57:34 INFO - 'HOME': '/home/cltbld', 06:57:34 INFO - 'LANG': 'en_US.UTF-8', 06:57:34 INFO - 'LANGUAGE': 'en_US:en', 06:57:34 INFO - 'LOGNAME': 'cltbld', 06:57:34 INFO - 'MAIL': '/var/mail/cltbld', 06:57:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:57:34 INFO - 'MOZ_NO_REMOTE': '1', 06:57:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:57:34 INFO - 'NO_EM_RESTART': '1', 06:57:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:57:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 06:57:34 INFO - 'PWD': '/builds/slave/test-pgo', 06:57:34 INFO - 'SHELL': '/bin/bash', 06:57:34 INFO - 'SHLVL': '1', 06:57:34 INFO - 'TERM': 'linux', 06:57:34 INFO - 'TMOUT': '86400', 06:57:34 INFO - 'USER': 'cltbld', 06:57:34 INFO - 'XDG_SESSION_COOKIE': '6ea65ccfe4e6b94e0d4f826f000001d8-1448290565.608392-1842730875', 06:57:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:57:34 INFO - '_': '/tools/buildbot/bin/python'} 06:57:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:57:34 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:57:34 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:57:34 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:57:34 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:57:34 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:57:34 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:57:34 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:57:34 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:57:34 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:57:34 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:57:34 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:57:34 INFO - Cleaning up... 06:57:34 INFO - Return code: 0 06:57:34 INFO - Running post-action listener: _resource_record_post_action 06:57:34 INFO - Running post-action listener: _start_resource_monitoring 06:57:34 INFO - Starting resource monitoring. 06:57:34 INFO - ##### 06:57:34 INFO - ##### Running install step. 06:57:34 INFO - ##### 06:57:34 INFO - Running pre-action listener: _resource_record_pre_action 06:57:34 INFO - Running main action method: install 06:57:34 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 06:57:34 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 06:57:34 INFO - Reading from file tmpfile_stdout 06:57:34 INFO - Detecting whether we're running mozinstall >=1.0... 06:57:34 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 06:57:34 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 06:57:34 INFO - Reading from file tmpfile_stdout 06:57:34 INFO - Output received: 06:57:34 INFO - Usage: mozinstall [options] installer 06:57:34 INFO - Options: 06:57:34 INFO - -h, --help show this help message and exit 06:57:34 INFO - -d DEST, --destination=DEST 06:57:34 INFO - Directory to install application into. [default: 06:57:34 INFO - "/builds/slave/test-pgo"] 06:57:34 INFO - --app=APP Application being installed. [default: firefox] 06:57:34 INFO - mkdir: /builds/slave/test-pgo/build/application 06:57:34 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:57:34 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:57:49 INFO - Reading from file tmpfile_stdout 06:57:49 INFO - Output received: 06:57:49 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 06:57:49 INFO - Running post-action listener: _resource_record_post_action 06:57:49 INFO - ##### 06:57:49 INFO - ##### Running run-tests step. 06:57:49 INFO - ##### 06:57:49 INFO - Running pre-action listener: _resource_record_pre_action 06:57:49 INFO - Running main action method: run_tests 06:57:49 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 06:57:49 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 06:57:49 INFO - Python 2.7.3 06:57:49 INFO - Return code: 0 06:57:49 INFO - grabbing minidump binary from tooltool 06:57: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:57:49 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 0x17e7a90>, '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 0x1839f70>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x183a2e0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 06:57:49 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:57:49 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:57:49 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 06:57:49 INFO - Return code: 0 06:57:49 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 06:57:49 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 06:57:49 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 06:57:49 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 06:57:49 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 06:57:49 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/h7cJle0OS72hT2EgK2u93g/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-037', '--webServer', 'localhost'] in /builds/slave/test-pgo/build 06:57:49 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/h7cJle0OS72hT2EgK2u93g/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-037 --webServer localhost 06:57:49 INFO - Using env: {'DISPLAY': ':0', 06:57:49 INFO - 'HOME': '/home/cltbld', 06:57:49 INFO - 'LANG': 'en_US.UTF-8', 06:57:49 INFO - 'LANGUAGE': 'en_US:en', 06:57:49 INFO - 'LOGNAME': 'cltbld', 06:57:49 INFO - 'MAIL': '/var/mail/cltbld', 06:57:49 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 06:57:49 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 06:57:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:57:49 INFO - 'MOZ_NO_REMOTE': '1', 06:57:49 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 06:57:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:57:49 INFO - 'NO_EM_RESTART': '1', 06:57:49 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:57:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 06:57:49 INFO - 'PWD': '/builds/slave/test-pgo', 06:57:49 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 06:57:49 INFO - 'SHELL': '/bin/bash', 06:57:49 INFO - 'SHLVL': '1', 06:57:49 INFO - 'TERM': 'linux', 06:57:49 INFO - 'TMOUT': '86400', 06:57:49 INFO - 'USER': 'cltbld', 06:57:49 INFO - 'XDG_SESSION_COOKIE': '6ea65ccfe4e6b94e0d4f826f000001d8-1448290565.608392-1842730875', 06:57:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:57:49 INFO - '_': '/tools/buildbot/bin/python'} 06:57:49 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/h7cJle0OS72hT2EgK2u93g/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-037', '--webServer', 'localhost'] with output_timeout 3600 06:57:49 INFO - mozversion INFO | application_buildid: 20151123053006 06:57:49 INFO - mozversion INFO | application_changeset: 4fc73ccc88ab992a6dc08962dab88261df1070b0 06:57:49 INFO - mozversion INFO | application_display_name: Nightly 06:57:49 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 06:57:49 INFO - mozversion INFO | application_name: Firefox 06:57:49 INFO - mozversion INFO | application_remotingname: firefox 06:57:49 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/b2g-inbound 06:57:49 INFO - mozversion INFO | application_vendor: Mozilla 06:57:49 INFO - mozversion INFO | application_version: 45.0a1 06:57:49 INFO - mozversion INFO | platform_buildid: 20151123053006 06:57:49 INFO - mozversion INFO | platform_changeset: 4fc73ccc88ab992a6dc08962dab88261df1070b0 06:57:49 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/b2g-inbound 06:57:49 INFO - mozversion INFO | platform_version: 45.0a1 06:57:49 INFO - 2015-11-23 06:57:49,313 DEBUG : using testdate: 1448290669 06:57:49 INFO - 2015-11-23 06:57:49,314 DEBUG : actual date: 1448290669 06:57:49 INFO - 2015-11-23 06:57:49,328 INFO : starting webserver on 'localhost:42996' 06:57:49 INFO - 2015-11-23 06:57:49,329 INFO : Starting test suite talos-linux64-ix-037 06:57:49 INFO - 2015-11-23 06:57:49,330 INFO : Starting test dromaeo_css 06:57:49 INFO - 2015-11-23 06:57:49,330 DEBUG : operating with platform_type : linux_ 06:57:49 INFO - 2015-11-23 06:57:49,330 INFO : Initialising browser for dromaeo_css test... 06:57:49 INFO - 2015-11-23 06:57:49,347 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpbU1RFH/profile http://localhost:42996/getInfo.html 06:57:53 INFO - 2015-11-23 06:57:53,361 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 06:57:53 INFO - 2015-11-23 06:57:53,361 DEBUG : BROWSER_OUTPUT: colorDepth:24 06:57:53 INFO - 2015-11-23 06:57:53,361 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 06:57:53 INFO - 2015-11-23 06:57:53,361 DEBUG : BROWSER_OUTPUT: __metrics 06:57:53 INFO - 2015-11-23 06:57:53,538 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:57:54 INFO - 2015-11-23 06:57:54,767 INFO : Browser initialized. 06:57:54 INFO - 2015-11-23 06:57:54,767 INFO : Running cycle 1/1 for dromaeo_css test... 06:57:54 INFO - 2015-11-23 06:57:54,768 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpbU1RFH/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 06:58:06 INFO - 2015-11-23 06:58:06,454 DEBUG : BROWSER_OUTPUT: RSS: Main: 141725696 06:58:06 INFO - 2015-11-23 06:58:06,454 DEBUG : BROWSER_OUTPUT: 06:58:57 INFO - 2015-11-23 06:58:57,253 DEBUG : BROWSER_OUTPUT: 1448290737252 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] 07:01:06 INFO - 2015-11-23 07:01:06,133 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:42996/tests/dromaeo/cssquery-dojo.html (next: http://localhost:42996/tests/dromaeo/cssquery-ext.html) 07:01:07 INFO - 2015-11-23 07:01:07,197 DEBUG : BROWSER_OUTPUT: RSS: Main: 231137280 07:01:07 INFO - 2015-11-23 07:01:07,198 DEBUG : BROWSER_OUTPUT: 07:04:09 INFO - 2015-11-23 07:04:09,598 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:42996/tests/dromaeo/cssquery-ext.html (next: http://localhost:42996/tests/dromaeo/cssquery-jquery.html) 07:04:10 INFO - 2015-11-23 07:04:10,170 DEBUG : BROWSER_OUTPUT: RSS: Main: 226652160 07:04:10 INFO - 2015-11-23 07:04:10,171 DEBUG : BROWSER_OUTPUT: 07:07:12 INFO - 2015-11-23 07:07:12,009 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:42996/tests/dromaeo/cssquery-jquery.html (next: http://localhost:42996/tests/dromaeo/cssquery-mootools.html) 07:07:12 INFO - 2015-11-23 07:07:12,594 DEBUG : BROWSER_OUTPUT: RSS: Main: 220880896 07:07:12 INFO - 2015-11-23 07:07:12,594 DEBUG : BROWSER_OUTPUT: 07:10:14 INFO - 2015-11-23 07:10:14,369 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:42996/tests/dromaeo/cssquery-mootools.html (next: http://localhost:42996/tests/dromaeo/cssquery-prototype.html) 07:10:14 INFO - 2015-11-23 07:10:14,963 DEBUG : BROWSER_OUTPUT: RSS: Main: 203096064 07:10:14 INFO - 2015-11-23 07:10:14,963 DEBUG : BROWSER_OUTPUT: 07:13:17 INFO - 2015-11-23 07:13:17,471 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:42996/tests/dromaeo/cssquery-prototype.html (next: http://localhost:42996/tests/dromaeo/cssquery-yui.html) 07:13:18 INFO - 2015-11-23 07:13:18,052 DEBUG : BROWSER_OUTPUT: RSS: Main: 207257600 07:13:18 INFO - 2015-11-23 07:13:18,052 DEBUG : BROWSER_OUTPUT: 07:16:20 INFO - 2015-11-23 07:16:20,665 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:42996/tests/dromaeo/cssquery-yui.html (next: http://localhost:42996/tests/dromaeo/cssquery-dojo.html) 07:16:20 INFO - 2015-11-23 07:16:20,923 DEBUG : BROWSER_OUTPUT: RSS: Main: 249487360 07:16:20 INFO - 2015-11-23 07:16:20,923 DEBUG : BROWSER_OUTPUT: 07:16:20 INFO - 2015-11-23 07:16:20,923 DEBUG : BROWSER_OUTPUT: __start_tp_report 07:16:20 INFO - 2015-11-23 07:16:20,924 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 07:16:20 INFO - 2015-11-23 07:16:20,924 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 07:16:20 INFO - 2015-11-23 07:16:20,924 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 07:16:20 INFO - 2015-11-23 07:16:20,924 DEBUG : BROWSER_OUTPUT: |0;dojo.html;3184.920376990575;3241.5623890774737;3245.8863939762114;3254.9837250813757;3270.8855190068343;5350.91973620396;5424.810131645393;5456.072467680494;5476.151196564534;5500.147477141045;5290.629655924087;5302.893942121155;5312.574994000481;5455.399906010346;5539.307586551681;4993.850184494462;5017.448080711137;5035.320231768719;5090.974545127269;5126.589872810185;268.73857404021936;4792.496787837279;5026.246063090529;5031.496850314976;5076.086304465195;4960.2559616057515;4982;5033.370828646419;5071.188609822448;5094.694318340893;4905.656604037718;4908.141075311842;4911.803527858881;4912.754362281871;4956.281339205831;4760.262159365304;4870.147724148295;4895.0944075345815;4924.852254432372;4929.926051109236;5089.185730283137;5186.040582492214;5218.373795144569;5218.947810521922;5251.921221181686;5790.565707571949;5791.536677065825;5792.102224155221;5794.855128621818;5850.297964244275;5559.110542313251;5635.915461268084;5847.941520584783;5854.18041474194;5878.764849406019;5577.553795696334;5577.8605534861545;5579.581531385163;5583.162525621149;5601.859953501195;6066.908996365058;6068.726907289182;6078.696065196811;6079.361667024988;6133.26400831903;5730.08318669011;5788.218590490314;5788.594798364074;5855.063189889597;5933.406659334032;5879.559033072536;5879.7060146993335;5893.764249430061;6033.064874944391;6071.392860713893;5837.6497410155525;5841.094630332305;5842.970785146047;5855.151003104611;5873.383294754075;5642.520385767174;5742.626729262584;5820.156077368758;5822.446867547576;5839.562032847553;4512.2329204035395;4525.660575456788;4555.020670555847;4600.746958917225;4606.424196975311;4048.554658987509;4055.9391609125296;4059.167870586523;4064.451299074587;4092.242935057024;5257.342832145981;5365.436629153961;5445.210444485528;5520.171974203821;5526.640768350125;5894.115882617642;5909.438603332676;5914.319853216849;5916.994111001054;6030.819075427744;5510.421405752339;5521.365043020024;5526.364468086141;5532.612717109763;5548.72256387179;4872.80508779652;4991.675541089818;5021.949780502221;5117.462666420047;5117.641765076483;6127.387261273837;6146.78486252979;6157.96921015401;6162.845928851814;6169.259688837278;5957.344692083954;5958.314793798769;5960.105984102419;5961.731722072604;5962.940370596239;5870.236869206976;6027.246594175728;6040.214772079602;6044.942135126424;6117.200569274211;5777.884442311214;5783.855403614775;5787;5807.157962095557;5903.409659034062;5817.389174136655;5838.357780644211;5879.059350503899;5884;5887.411258874078;5626.971865140648;5631.605787594829;5702.857428564319;5745.224394706661;5754.769809207585;5691.117876729114;5692.943070569241;5694.943050569441;5709.628874123168;5729.1119876419225;5576.275084239023;5582.302212223472;5587.944120558743;5590.385057643574;5595.160725891149;5613.129964855454;5717.828465146053;5720.256366672306;5768.596198266249;5769.769209231584;5693.800716974886;5718.742656580381;5723.370429252862;5728.770849165987;5760.423957604206 07:16:20 INFO - 2015-11-23 07:16:20,924 DEBUG : BROWSER_OUTPUT: |1;ext.html;580.0747807247442;581.8603535151564;589.884972430376;591.110378879786;601.8375038739538;31843.840780796094;38587;38679.61320386795;38874.99999999993;39034.804825975865;40545.797271013675;40878.99999999993;40955.18089638205;40995.38506922399;41033.79483102588;7679.539227646331;7806.804829879242;8626.827463450743;8817.647294108228;8823.95588022059;10517.84223236652;10764.407957562331;10774.353538787698;10777.83833242502;10798.67603971882;10402;10504.842427363596;10513.894861051407;10518;10518.526666300035;7891.684332626717;8008.119106898236;8063.153368896299;10417.479126043705;10509.106725928228;10187.643432479828;10337.948310258476;10338.483075846252;10338.948305258426;10342.276040677156;40975;41206.79396603028;41445.171096578204;41473.377899331535;41509.169816603804;3448.0345503259127;3471.583409990792;3710.239400922804;3899.961000389988;4026.45642838216;30647.38705225905;30767.230819229473;31121.533177002362;31652.366952661047;32046.83976580102;3941.487606611151;3957.2679054374744;3977.5425826030087;3989.3617021276455;4047.5547689754103;277383;277952;278043;278316;278875;53371.19943200855;54429;60079;67632.32367676261;68829.31170688229;62163.37836621666;62333;62450.68774656098;62532;62656.686716566124;15882.920585397;16030.358785648443;16128.435504757277;16133.354665813471;16140.112293823953;12211.75576488483;12274.570390036484;12368.938155309166;12373.319467429377;12545.811812822814;20312.898435507726;20420.285290014777;20433.69349459759;20649.380518584465;20658.380248592566;7029.472789540805;7265.4187664986675;7305.269473052652;7313.817154571072;7353.1911489736085;940.47333493244;1021.3310281765456;1024.8975102489692;1072.4048153275007;1083.8482612434266;30936.535951960737;31751.919692849035;31843.681563184535;31939.520907186412;32118.678813212035;999.3853779925294;1005.703317521333;1023.5854478936043;1056.8837427882927;1083.5394957143183;14933.850661493247;14991.775123373158;15016.849831501546;15077.170755608548;15301.617459563377;329666;332963;335515;335889;336065;53733.46266537363;53806;53911;53998.19002714963;54190;1360.190686541526;1370.8012338210904;1376.8072469854228;1378.221304962713;1390.986090139106;26143.346416339744;28316.292092697848;28791.712082878905;29247.268818279714;29275.268118297212;50116;50604.74697626635;50624.74687626538;50703.74648126736;50728.22451214337;283915;284972;285070;286285;287250;28386.716132838406;28806.567901481074;31127.53308700326;32473.51289730703;32874.83562582172;39202.01994950149;39383.21233575255;40469;40736.3889541663;43620.56379436165;36327.45508817317;36756;36996;39467.40798887962;39929.40105898472;29334;34614.653853461146;35580.64419355877;36953.076173094814;37570.436443452825;33512.83243583766;33789.66210337865;35705.15594149268;35756.28487430289;36391;29724.702752972193;31344.52983205208;31641.8417907909;31781.682183177873;31854.203644908135;23607.40981475477;23744.287671369886;23783.643245350988;23983.160589379288;24227.878860605586 07:16:20 INFO - 2015-11-23 07:16:20,924 DEBUG : BROWSER_OUTPUT: |2;jquery.html;355.1901664205612;356.50623885918003;358.81769569269255;358.9982050089751;360.18597968590984;13670.111442756213;13946.23295718735;16610.66778664426;16913.40803071891;17588.824111758877;15324.770128448083;15931.283092260846;16228.269727862245;16391.59021024475;16400.507984760447;5247.449017853118;5367.194920761878;5369.838904832842;5372.758225879845;5375.543078838304;4031.173609410064;4147.232761939036;5303.787848486056;5337.11937530307;5921.911171332434;5980.73086711099;6006.939930600682;6034.943884820161;6038.33578306386;6042.848928776772;5816.185733997244;5925.08161235005;5932.169496270504;5943.821685349447;5953.464188223059;5138.484147176555;5208.348956380452;5208.453112423217;5211.42674305826;5233.084210263227;20335.49161270965;20426.38720838377;20637.17451301946;20663.380098597067;20709.378718638465;2016.4656366063004;2133.615949129156;2146.6350720377573;2288.1762565476415;2660.5344064788583;8990.325725570543;9324.440533568008;9356.71929842099;12909.67725806853;13238.27189504577;1787.34761811939;1806.7741532308462;1847.2057015483338;1887.7262796894374;1905.1522072677665;58368.70815645937;61598.38401615971;61821.38178618201;63981.68009159924;65825.67087164581;9530.571124299424;9870.851937220947;9955.303128780915;9974.40153590787;10017.549210285555;13306.201627902357;13315.40080696371;13317.866821331663;13332.800007999887;13338.19970801755;7411.85176296471;7411.925880741232;7445.25547445262;7451.627418629047;7457.32884040439;7202.1357437106835;7213.531120477152;7225.5664660120565;7227.602481863443;7277.3086556777025;4341.82632694695;4354.716943398669;4358.629516491071;4359.324304732771;4382.912341753147;1576.3064251729202;1640.7620894970162;1755.5260079778388;1806.5483629092728;1816.8728189026642;897.9775505612412;921.166344458253;922.5663937949154;1041.8176819056634;1044.0603456888862;16103.27535260916;16229.350825966829;16295.755563666555;16625;16645.33418663264;890.4345740454858;925.6991477769752;927.4759760735163;949.9620015199453;991.1030517381781;7715.807104822425;9007.549622518847;9105.271578273721;9534.237261019101;9741.123298903132;533269;536125;553194;557462;565205;80272;83519.5824020876;83651;83722.16277837266;84264.57867710623;1052.3580615824342;1078.9946050269698;1098.6923661374828;1136.3068528197794;1139.7549526851767;15011.924940375227;15025.549233523012;15086.24568771535;15212.239388030333;15650.686986260438;33300.333993320484;33551.664483354856;34187.14532136716;34967.475487867196;35734.4639830408;42893.571064290205;42981;43770.56229437665;44196;45375.546244538455;9449.622015119317;9466.857997130186;9702.85445718329;9703.690001849942;9718.271129665161;12805.8079128815;17348.739768903728;17374;17922.64154716872;18041.548961276072;14448.638784030483;14498.275086245856;14744.55766327012;14879.330430130887;14890.478833240784;13939.860601394263;13962.37169327403;14491.660796317276;14610.415583376545;14645;14665.41338346497;14744.336504857522;14804.629884252548;15072.773908391164;15389.692206156038;9443.197328227177;9512.619495220113;9556.713298601053;9565.378250413702;9566.426014439156;14300.499482518062;14300.856991429953;14542.709145817236;14669.633259168606;15104.39582416691 07:16:20 INFO - 2015-11-23 07:16:20,926 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1262.3372729317114;1700.5493544210785;1739.9043052632107;1767.6376342849717;1772.3796671165094;6748.527603067787;7369.410447164228;7435.921791340253;7445.739399121032;7470.626468676572;7621.657025433855;7742.535447873118;7750.496217745843;7768.88346674799;7776.650050747716;2062.9896850515725;2107.725995620567;2274.727032756063;2300.9769902300973;2324.651302304651;2336.7663233676667;2340.595642614435;2342.367560758594;2344.132670911765;2346.296111166643;2249.403907964391;2288.347820871052;2289.2445492987276;2292.7592602776717;2293.9541209175804;1757.7627020352218;1791.3819732192374;2244.259394399844;2295.6556516522487;2296.81625469962;2311.433698743802;2318;2332.8017118544944;2345.5074434368803;2384.2966324934014;7713.267239612228;7797.337226335769;7801.843963120706;7805.1804560520895;7809.414293927921;4606.792694328763;4667.509911459316;4672.929906051412;4705.176594096054;4705.976470117627;3005.6242969628797;3040.437519058959;3067.708567686066;3091.1499337682094;3192.2817366092677;981.087588542655;1002.6691191906654;1006.4263369879171;1026.015025575441;1053.9104176145038;10945.83581246282;10966.670999870017;10969.670909872717;10985.066269367113;10996.945015275032;4124.546299907008;4255.702100852973;4302.569743025735;4303.440552728125;4303.462067241595;9328.533573321307;9334.579943902405;9336.859947100798;9340.439573625605;9341.719748407559;4690.742009189459;4712.575868171881;4754.95245047552;4755.405574303212;4756.9762151189025;4297.849575264913;4335.653147748236;4340.131973605292;4349.217140914602;4349.28236840924;3741.6819570336284;3776.4901738264984;3783.6783873370523;3794.3739283018544;3831.2912111259507;1211.0311750599485;1216.92698438094;1221.4686611324103;1230.5816022552197;1232.3776492871043;1071.844582535528;1092.63396762084;1093.4696672114019;1221.328269451798;1311.9212847229196;7123.857522849514;7141.89287160693;7160.713571457188;7164.068671072727;7442.516236444614;1099.0767755085767;1118.6196693124214;1118.6364431559775;1125.3135587291745;1138.7494751154732;5681.375048744718;5699.857503562361;5731.226284451629;5923.466887980103;5938.168656388109;9115.772105697411;9388.389754665925;9399.389039712534;9409.153176214173;9438.528073596293;9134.086591340812;9171.037041110587;9290.256779457628;9355.87729472454;9367.344285899922;7103.112110986127;7104.893426598605;7164.21193668696;7165.462590305748;7172.856542869218;7004.579725216299;7133.429325653831;7145.321194486515;7147.356737893615;7183.928160718326;8157.592120394075;8450.281726053108;8470.364722645703;8472.406931514735;8615.6984505542;8537.701180458655;8568.700095496628;8654;8704;8754.956225218833;6786.083878676315;6846.554973926679;6851.9657401712675;6882.311768823078;6898.8620227596175;7597.848043039219;7792.454528182972;7844.607769611611;7849.215078492105;7849.411294153076;6534.150560427114;6948.478864085113;6975.581465112109;7088.220295767358;7420.480566360303;7015.649217539205;7048.682809273698;7069.575825450489;7087.114110736158;7103.360697537247;7008.299170082951;7051.330123638246;7055.929440705732;7079.929200707927;7083.822904427225;6167.907481387693;6210.006398976142;6214.471769899428;6222.160008398808;6233.314335423009;6427.357264273535;6429.485641148791;6448.806535803933;6449.032645103272;6462.030695395728 07:16:20 INFO - 2015-11-23 07:16:20,927 DEBUG : BROWSER_OUTPUT: |4;prototype.html;331.57227176941745;333.40154422811054;338.6900985598178;341.5491551152478;346.98091604961735;5802.042662960617;5932.88134237315;5959.553033522487;5981.252343457062;6046.697665116749;5799.420057994198;5952.523798096142;5978.6412815231115;5980.671063091529;5996.340402555716;4614.446266448014;4633.490316065238;4645.442546894377;4647.86056418308;4661.09108723799;4455.086707225011;4516.796744146505;4566.634669226454;4644.187267228222;4652.930206046912;4591.908161836761;4594.931076033846;4610.5850473457385;4613.792379342921;4616.538346165374;4599.977000114995;4608.907821843544;4613.976930115345;4622.884427889296;4627.8611641650805;4088.1619268050276;4091.9386209206887;4092.5498195198506;4101.630853223224;4104.651104656108;5605.943940560583;5709.543236541067;5710.2862142232225;5714.885702285931;5718.885622287531;5384.461553844623;5391.137418013138;5397.379301380352;5402.567794576464;5406.405295417501;6121.081837724332;6337.397947195009;6338.936610633927;6351.491880649537;6354.364563543655;4412.977935110304;4424.557544245582;4503.729776213405;4517.570830771071;4523.7285762854335;6606.669666516703;6624.569402988838;6627.237867645186;6627.469802415795;6632.734690612418;4633.351330813622;4644.140833945731;4649.651276154302;4650.000249946278;4650.95349046512;4452.888677783081;4565.885852853638;4574.039451715177;4697.389339385858;4699.342092107107;5272.578193744491;5295.655782374133;5300.337457817773;5300.946990530122;5305.62860599762;6426.196725409324;6428.389303016206;6430.646314452656;6432.388923052303;6436.324185960407;1593.1237819199625;1629.413411171977;1630.2174956021177;1631.5023917705214;1632.3470611755156;1065.1532032034552;1081.3944191252767;1085.3976043296047;1105.309181761399;1112.5382966069153;6102.4507794298725;6114.633122012605;6117.388261173847;6119.296280927751;6119.510439164945;6539.50953678476;6550.672466376662;6554.80335589933;6577.177852768404;6596.901046484307;5965.28416590012;6088.178095957078;6111.419415155553;6114.144019837227;6120.938790612036;3555.2178520725397;3594.658507441789;3595.802230877327;3596.730245231618;3599.5140656011627;6850.21222559412;6851.623160726208;6853.691583878737;6856.760013399507;6865.828354291083;6628.469722422291;6778.322167783281;6782.660866956731;6786.049953006583;6801.591904485746;6759.087523184406;6837.658117094026;6843.452523798084;6845.281245469154;6852.965735171392;6350.841228969312;6445.097686323825;6507.089007538853;6557.180352455943;6590.538662293593;6525.804225873231;6588.155316511385;6602.636854973022;6614.867702646016;6616.867662646817;6888.896666550106;6891.241963384124;6891.655417229018;6892.551984121016;6894.069300644549;4483.663725220556;4530.501644819134;4543.228141024937;4565.7717114144825;4574.085182963488;6613.14029176204;6616.636085015371;6617.702203400955;6622.63575503352;6645.335466453316;6461.676916154268;6468.514861385321;6469.676516174267;6472.126262954629;6474.741010359721;6316.273628532594;6446.484281257582;6454.225492940877;6490.123833282447;6494.967525162344;6361.968190159205;6363.3000369958345;6364.618122912455;6380.457661098673;6381.776637817654;6491.188601424822;6495.870082598227;6501.122348483083;6504.1219435375615;6508;6207.224096987877;6345.111684364285;6350.936490635035;6356.141920840627;6356.936430635819 07:16:20 INFO - 2015-11-23 07:16:20,930 DEBUG : BROWSER_OUTPUT: |5;yui.html;747.7121308296307;764.9311561959419;840.8402403543326;863.5595846118478;898.04806904681;13429.999999999987;13718.245496497688;13724.931375343109;13740.244286564248;13762.311884405777;13122.803157952638;13196.670083247924;13210.603681889559;13213.603591892235;13221.471141154343;662.8442316055723;677.6239187251099;798.3413683710933;820.2248874813274;823.0329362998483;824.575343697996;826.5990994367727;832.5337810825927;832.546262287052;832.7460124661976;700.530644468205;850.3622283287534;854.1031916487694;856.575994882534;857.8970523537184;705.1221229569194;708.2917082917083;710.261328218652;847.639753104928;858.8797568340437;634.8508100596356;635.0569404434411;636.2333388267127;637.101686621861;637.5186734015834;13447;13588.38852251651;13658.795118073138;13664.65838354039;13685.521006764715;12143.574974875837;12775.552855650101;13249.536266230733;13267.734645307137;13484.528041518499;9390.671326503609;9444.05559444057;9989;10304.96950304971;10376.118029967462;3605.6574625410544;3660.103274697716;3664.2305115925687;3770.9057273568105;3786.2238241160494;43677.78161109206;44021.11957760859;44114.338284925754;44300.11399772019;44444;9702.037229209483;9787.119159275699;9823.656172033945;10018.148457381058;10078.496075196212;18901.7164742529;18910.243590256236;18936.526586835163;18966.620667586572;18979.620407592047;7324.37742791858;7454.813629659302;7501.849963000818;7575.659095340723;7709;4144;4194.874153775391;4198.685098617616;4282.593153650399;4317.501496707257;3149.889753858604;3163.731082857983;3166.5566820645126;3168.556402103707;3184.331290429036;544.7194694732216;562.3785716782896;568.7867049856304;579.273012369482;586.4838941731249;611.4099893602695;651.2900937977532;660.4155322539491;667.7395815631908;679.6789854354483;7856.25365590268;8307.792305192419;8398.664053437917;8826.955865220762;9106.544672766335;497.5745737394548;647.9546431749732;658.6048370977471;664.8470851704135;679.8028571714148;3603.837827297778;4033.052232725307;4074.7758873262255;4155.376693495939;4170.436991006175;54456;55316;55427.72286138624;55980.440195598334;56055;47583.52416475791;48743.5125648746;48873;50498.24252636213;50719.73200669939;42591.36112958308;43277.567224327984;43542.56457435385;43668.34497482604;44007;8166.918330816853;8290.854572713642;8292.834143316979;8310.21052999964;8450.281726053354;33579.328413432086;33747.156321091185;34223.31553368968;34486.3443435133;34712.82643586766;39676.60323396729;41623.58376416318;42686;43019.56980430281;43318.566814331454;10512.106470950055;10751.19366047534;10955.466234726986;11004.889951100387;11071.391073491035;11168.497417616065;11553.82669259945;11817.586384476503;11999.880001200225;12526.561570344995;10892.128629709763;10989.725256868642;11026.614068507564;11311.151663625425;11408.201425900439;10050.849237261593;10447.529861156418;10451.16390688728;10481.737956551147;10836;9795.559199836167;10795.784084318113;10823.51294191779;10982;11220.831687524531;8959.955200223958;9112.134347237003;9124.224440922597;9142.954285228532;9431.905680943102;8254.42219044661;8395.622197001272;9076.954615226881;9078.182963533049;9115.863262051207 07:16:20 INFO - 2015-11-23 07:16:20,931 DEBUG : BROWSER_OUTPUT: __end_tp_report 07:16:20 INFO - 2015-11-23 07:16:20,931 DEBUG : BROWSER_OUTPUT: __start_cc_report 07:16:20 INFO - 2015-11-23 07:16:20,931 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,897 07:16:20 INFO - 2015-11-23 07:16:20,931 DEBUG : BROWSER_OUTPUT: __end_cc_report 07:16:20 INFO - 2015-11-23 07:16:20,931 DEBUG : BROWSER_OUTPUT: __startTimestamp1448291780916__endTimestamp 07:16:20 INFO - 2015-11-23 07:16:20,931 DEBUG : BROWSER_OUTPUT: 07:16:20 INFO - 2015-11-23 07:16:20,932 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 07:16:20 INFO - 2015-11-23 07:16:20,932 DEBUG : BROWSER_OUTPUT: Number of tests: 6 07:16:20 INFO - 2015-11-23 07:16:20,932 DEBUG : BROWSER_OUTPUT: 07:16:20 INFO - 2015-11-23 07:16:20,932 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:5410.78 Median:5626.97 stddev:732.59 (13.0%) stddev-sans-first:713.72 07:16:20 INFO - 2015-11-23 07:16:20,932 DEBUG : BROWSER_OUTPUT: Values: 3184.9 3241.6 3245.9 3255.0 3270.9 5350.9 5424.8 5456.1 5476.2 5500.1 5290.6 5302.9 5312.6 5455.4 5539.3 4993.9 5017.4 5035.3 5091.0 5126.6 268.7 4792.5 5026.2 5031.5 5076.1 4960.3 4982.0 5033.4 5071.2 5094.7 4905.7 4908.1 4911.8 4912.8 4956.3 4760.3 4870.1 4895.1 4924.9 4929.9 5089.2 5186.0 5218.4 5218.9 5251.9 5790.6 5791.5 5792.1 5794.9 5850.3 5559.1 5635.9 5847.9 5854.2 5878.8 5577.6 5577.9 5579.6 5583.2 5601.9 6066.9 6068.7 6078.7 6079.4 6133.3 5730.1 5788.2 5788.6 5855.1 5933.4 5879.6 5879.7 5893.8 6033.1 6071.4 5837.6 5841.1 5843.0 5855.2 5873.4 5642.5 5742.6 5820.2 5822.4 5839.6 4512.2 4525.7 4555.0 4600.7 4606.4 4048.6 4055.9 4059.2 4064.5 4092.2 5257.3 5365.4 5445.2 5520.2 5526.6 5894.1 5909.4 5914.3 5917.0 6030.8 5510.4 5521.4 5526.4 5532.6 5548.7 4872.8 4991.7 5021.9 5117.5 5117.6 6127.4 6146.8 6158.0 6162.8 6169.3 5957.3 5958.3 5960.1 5961.7 5962.9 5870.2 6027.2 6040.2 6044.9 6117.2 5777.9 5783.9 5787.0 5807.2 5903.4 5817.4 5838.4 5879.1 5884.0 5887.4 5627.0 5631.6 5702.9 5745.2 5754.8 5691.1 5692.9 5694.9 5709.6 5729.1 5576.3 5582.3 5587.9 5590.4 5595.2 5613.1 5717.8 5720.3 5768.6 5769.8 5693.8 5718.7 5723.4 5728.8 5760.4 07:16:20 INFO - 2015-11-23 07:16:20,933 DEBUG : BROWSER_OUTPUT: 07:16:20 INFO - 2015-11-23 07:16:20,933 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:47289.91 Median:32674.17 stddev:78440.73 (240.1%) stddev-sans-first:78582.38 07:16:20 INFO - 2015-11-23 07:16:20,934 DEBUG : BROWSER_OUTPUT: Values: 580.1 581.9 589.9 591.1 601.8 31843.8 38587.0 38679.6 38875.0 39034.8 40545.8 40879.0 40955.2 40995.4 41033.8 7679.5 7806.8 8626.8 8817.6 8824.0 10517.8 10764.4 10774.4 10777.8 10798.7 10402.0 10504.8 10513.9 10518.0 10518.5 7891.7 8008.1 8063.2 10417.5 10509.1 10187.6 10337.9 10338.5 10338.9 10342.3 40975.0 41206.8 41445.2 41473.4 41509.2 3448.0 3471.6 3710.2 3900.0 4026.5 30647.4 30767.2 31121.5 31652.4 32046.8 3941.5 3957.3 3977.5 3989.4 4047.6 277383.0 277952.0 278043.0 278316.0 278875.0 53371.2 54429.0 60079.0 67632.3 68829.3 62163.4 62333.0 62450.7 62532.0 62656.7 15882.9 16030.4 16128.4 16133.4 16140.1 12211.8 12274.6 12368.9 12373.3 12545.8 20312.9 20420.3 20433.7 20649.4 20658.4 7029.5 7265.4 7305.3 7313.8 7353.2 940.5 1021.3 1024.9 1072.4 1083.8 30936.5 31751.9 31843.7 31939.5 32118.7 999.4 1005.7 1023.6 1056.9 1083.5 14933.9 14991.8 15016.8 15077.2 15301.6 329666.0 332963.0 335515.0 335889.0 336065.0 53733.5 53806.0 53911.0 53998.2 54190.0 1360.2 1370.8 1376.8 1378.2 1391.0 26143.3 28316.3 28791.7 29247.3 29275.3 50116.0 50604.7 50624.7 50703.7 50728.2 283915.0 284972.0 285070.0 286285.0 287250.0 28386.7 28806.6 31127.5 32473.5 32874.8 39202.0 39383.2 40469.0 40736.4 43620.6 36327.5 36756.0 36996.0 39467.4 39929.4 29334.0 34614.7 35580.6 36953.1 37570.4 33512.8 33789.7 35705.2 35756.3 36391.0 29724.7 31344.5 31641.8 31781.7 31854.2 23607.4 23744.3 23783.6 23983.2 24227.9 07:16:20 INFO - 2015-11-23 07:16:20,934 DEBUG : BROWSER_OUTPUT: 07:16:20 INFO - 2015-11-23 07:16:20,934 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:29154.56 Median:4089.20 stddev:89759.47 (2195.0%) stddev-sans-first:89985.22 07:16:20 INFO - 2015-11-23 07:16:20,934 DEBUG : BROWSER_OUTPUT: Values: 355.2 356.5 358.8 359.0 360.2 13670.1 13946.2 16610.7 16913.4 17588.8 15324.8 15931.3 16228.3 16391.6 16400.5 5247.4 5367.2 5369.8 5372.8 5375.5 4031.2 4147.2 5303.8 5337.1 5921.9 5980.7 6006.9 6034.9 6038.3 6042.8 5816.2 5925.1 5932.2 5943.8 5953.5 5138.5 5208.3 5208.5 5211.4 5233.1 20335.5 20426.4 20637.2 20663.4 20709.4 2016.5 2133.6 2146.6 2288.2 2660.5 8990.3 9324.4 9356.7 12909.7 13238.3 1787.3 1806.8 1847.2 1887.7 1905.2 58368.7 61598.4 61821.4 63981.7 65825.7 9530.6 9870.9 9955.3 9974.4 10017.5 13306.2 13315.4 13317.9 13332.8 13338.2 7411.9 7411.9 7445.3 7451.6 7457.3 7202.1 7213.5 7225.6 7227.6 7277.3 4341.8 4354.7 4358.6 4359.3 4382.9 1576.3 1640.8 1755.5 1806.5 1816.9 898.0 921.2 922.6 1041.8 1044.1 16103.3 16229.4 16295.8 16625.0 16645.3 890.4 925.7 927.5 950.0 991.1 7715.8 9007.5 9105.3 9534.2 9741.1 533269.0 536125.0 553194.0 557462.0 565205.0 80272.0 83519.6 83651.0 83722.2 84264.6 1052.4 1079.0 1098.7 1136.3 1139.8 15011.9 15025.5 15086.2 15212.2 15650.7 33300.3 33551.7 34187.1 34967.5 35734.5 42893.6 42981.0 43770.6 44196.0 45375.5 9449.6 9466.9 9702.9 9703.7 9718.3 12805.8 17348.7 17374.0 17922.6 18041.5 14448.6 14498.3 14744.6 14879.3 14890.5 13939.9 13962.4 14491.7 14610.4 14645.0 14665.4 14744.3 14804.6 15072.8 15389.7 9443.2 9512.6 9556.7 9565.4 9566.4 14300.5 14300.9 14542.7 14669.6 15104.4 07:16:20 INFO - 2015-11-23 07:16:20,934 DEBUG : BROWSER_OUTPUT: 07:16:20 INFO - 2015-11-23 07:16:20,935 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5465.73 Median:6212.24 stddev:2830.88 (45.6%) stddev-sans-first:2821.19 07:16:20 INFO - 2015-11-23 07:16:20,935 DEBUG : BROWSER_OUTPUT: Values: 1262.3 1700.5 1739.9 1767.6 1772.4 6748.5 7369.4 7435.9 7445.7 7470.6 7621.7 7742.5 7750.5 7768.9 7776.7 2063.0 2107.7 2274.7 2301.0 2324.7 2336.8 2340.6 2342.4 2344.1 2346.3 2249.4 2288.3 2289.2 2292.8 2294.0 1757.8 1791.4 2244.3 2295.7 2296.8 2311.4 2318.0 2332.8 2345.5 2384.3 7713.3 7797.3 7801.8 7805.2 7809.4 4606.8 4667.5 4672.9 4705.2 4706.0 3005.6 3040.4 3067.7 3091.1 3192.3 981.1 1002.7 1006.4 1026.0 1053.9 10945.8 10966.7 10969.7 10985.1 10996.9 4124.5 4255.7 4302.6 4303.4 4303.5 9328.5 9334.6 9336.9 9340.4 9341.7 4690.7 4712.6 4755.0 4755.4 4757.0 4297.8 4335.7 4340.1 4349.2 4349.3 3741.7 3776.5 3783.7 3794.4 3831.3 1211.0 1216.9 1221.5 1230.6 1232.4 1071.8 1092.6 1093.5 1221.3 1311.9 7123.9 7141.9 7160.7 7164.1 7442.5 1099.1 1118.6 1118.6 1125.3 1138.7 5681.4 5699.9 5731.2 5923.5 5938.2 9115.8 9388.4 9399.4 9409.2 9438.5 9134.1 9171.0 9290.3 9355.9 9367.3 7103.1 7104.9 7164.2 7165.5 7172.9 7004.6 7133.4 7145.3 7147.4 7183.9 8157.6 8450.3 8470.4 8472.4 8615.7 8537.7 8568.7 8654.0 8704.0 8755.0 6786.1 6846.6 6852.0 6882.3 6898.9 7597.8 7792.5 7844.6 7849.2 7849.4 6534.2 6948.5 6975.6 7088.2 7420.5 7015.6 7048.7 7069.6 7087.1 7103.4 7008.3 7051.3 7055.9 7079.9 7083.8 6167.9 6210.0 6214.5 6222.2 6233.3 6427.4 6429.5 6448.8 6449.0 6462.0 07:16:20 INFO - 2015-11-23 07:16:20,935 DEBUG : BROWSER_OUTPUT: 07:16:20 INFO - 2015-11-23 07:16:20,936 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:5359.53 Median:6067.44 stddev:1609.22 (26.5%) stddev-sans-first:1568.86 07:16:20 INFO - 2015-11-23 07:16:20,936 DEBUG : BROWSER_OUTPUT: Values: 331.6 333.4 338.7 341.5 347.0 5802.0 5932.9 5959.6 5981.3 6046.7 5799.4 5952.5 5978.6 5980.7 5996.3 4614.4 4633.5 4645.4 4647.9 4661.1 4455.1 4516.8 4566.6 4644.2 4652.9 4591.9 4594.9 4610.6 4613.8 4616.5 4600.0 4608.9 4614.0 4622.9 4627.9 4088.2 4091.9 4092.5 4101.6 4104.7 5605.9 5709.5 5710.3 5714.9 5718.9 5384.5 5391.1 5397.4 5402.6 5406.4 6121.1 6337.4 6338.9 6351.5 6354.4 4413.0 4424.6 4503.7 4517.6 4523.7 6606.7 6624.6 6627.2 6627.5 6632.7 4633.4 4644.1 4649.7 4650.0 4651.0 4452.9 4565.9 4574.0 4697.4 4699.3 5272.6 5295.7 5300.3 5300.9 5305.6 6426.2 6428.4 6430.6 6432.4 6436.3 1593.1 1629.4 1630.2 1631.5 1632.3 1065.2 1081.4 1085.4 1105.3 1112.5 6102.5 6114.6 6117.4 6119.3 6119.5 6539.5 6550.7 6554.8 6577.2 6596.9 5965.3 6088.2 6111.4 6114.1 6120.9 3555.2 3594.7 3595.8 3596.7 3599.5 6850.2 6851.6 6853.7 6856.8 6865.8 6628.5 6778.3 6782.7 6786.0 6801.6 6759.1 6837.7 6843.5 6845.3 6853.0 6350.8 6445.1 6507.1 6557.2 6590.5 6525.8 6588.2 6602.6 6614.9 6616.9 6888.9 6891.2 6891.7 6892.6 6894.1 4483.7 4530.5 4543.2 4565.8 4574.1 6613.1 6616.6 6617.7 6622.6 6645.3 6461.7 6468.5 6469.7 6472.1 6474.7 6316.3 6446.5 6454.2 6490.1 6495.0 6362.0 6363.3 6364.6 6380.5 6381.8 6491.2 6495.9 6501.1 6504.1 6508.0 6207.2 6345.1 6350.9 6356.1 6356.9 07:16:20 INFO - 2015-11-23 07:16:20,936 DEBUG : BROWSER_OUTPUT: 07:16:20 INFO - 2015-11-23 07:16:20,936 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:13318.66 Median:44207.23 stddev:15120.57 (34.2%) stddev-sans-first:15133.51 07:16:20 INFO - 2015-11-23 07:16:20,936 DEBUG : BROWSER_OUTPUT: Values: 747.7 764.9 840.8 863.6 898.0 13430.0 13718.2 13724.9 13740.2 13762.3 13122.8 13196.7 13210.6 13213.6 13221.5 662.8 677.6 798.3 820.2 823.0 824.6 826.6 832.5 832.5 832.7 700.5 850.4 854.1 856.6 857.9 705.1 708.3 710.3 847.6 858.9 634.9 635.1 636.2 637.1 637.5 13447.0 13588.4 13658.8 13664.7 13685.5 12143.6 12775.6 13249.5 13267.7 13484.5 9390.7 9444.1 9989.0 10305.0 10376.1 3605.7 3660.1 3664.2 3770.9 3786.2 43677.8 44021.1 44114.3 44300.1 44444.0 9702.0 9787.1 9823.7 10018.1 10078.5 18901.7 18910.2 18936.5 18966.6 18979.6 7324.4 7454.8 7501.8 7575.7 7709.0 4144.0 4194.9 4198.7 4282.6 4317.5 3149.9 3163.7 3166.6 3168.6 3184.3 544.7 562.4 568.8 579.3 586.5 611.4 651.3 660.4 667.7 679.7 7856.3 8307.8 8398.7 8827.0 9106.5 497.6 648.0 658.6 664.8 679.8 3603.8 4033.1 4074.8 4155.4 4170.4 54456.0 55316.0 55427.7 55980.4 56055.0 47583.5 48743.5 48873.0 50498.2 50719.7 42591.4 43277.6 43542.6 43668.3 44007.0 8166.9 8290.9 8292.8 8310.2 8450.3 33579.3 33747.2 34223.3 34486.3 34712.8 39676.6 41623.6 42686.0 43019.6 43318.6 10512.1 10751.2 10955.5 11004.9 11071.4 11168.5 11553.8 11817.6 11999.9 12526.6 10892.1 10989.7 11026.6 11311.2 11408.2 10050.8 10447.5 10451.2 10481.7 10836.0 9795.6 10795.8 10823.5 10982.0 11220.8 8960.0 9112.1 9124.2 9143.0 9431.9 8254.4 8395.6 9077.0 9078.2 9115.9 07:16:20 INFO - 2015-11-23 07:16:20,936 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 07:16:20 INFO - 2015-11-23 07:16:20,937 DEBUG : BROWSER_OUTPUT: 07:16:21 INFO - 2015-11-23 07:16:21,609 INFO : Browser exited with error code: 0 07:16:21 INFO - 2015-11-23 07:16:21,632 INFO : Completed test dromaeo_css (00:18:32) 07:16:21 INFO - 2015-11-23 07:16:21,633 INFO : Starting test kraken 07:16:21 INFO - 2015-11-23 07:16:21,633 DEBUG : operating with platform_type : linux_ 07:16:21 INFO - 2015-11-23 07:16:21,633 INFO : Initialising browser for kraken test... 07:16:21 INFO - 2015-11-23 07:16:21,639 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpoX1nde/profile http://localhost:42996/getInfo.html 07:16:25 INFO - 2015-11-23 07:16:25,365 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 07:16:25 INFO - 2015-11-23 07:16:25,365 DEBUG : BROWSER_OUTPUT: colorDepth:24 07:16:25 INFO - 2015-11-23 07:16:25,365 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 07:16:25 INFO - 2015-11-23 07:16:25,365 DEBUG : BROWSER_OUTPUT: __metrics 07:16:25 INFO - 2015-11-23 07:16:25,562 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:16:26 INFO - 2015-11-23 07:16:26,858 INFO : Browser initialized. 07:16:26 INFO - 2015-11-23 07:16:26,858 INFO : Running cycle 1/1 for kraken test... 07:16:26 INFO - 2015-11-23 07:16:26,858 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpoX1nde/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 07:16:38 INFO - 2015-11-23 07:16:38,596 DEBUG : BROWSER_OUTPUT: RSS: Main: 142176256 07:16:38 INFO - 2015-11-23 07:16:38,596 DEBUG : BROWSER_OUTPUT: 07:16:41 INFO - 2015-11-23 07:16:41,076 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:42996/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:42996/tests/kraken/driver.html?testName=audio-beat-detection) 07:16:41 INFO - 2015-11-23 07:16:41,662 DEBUG : BROWSER_OUTPUT: RSS: Main: 179191808 07:16:41 INFO - 2015-11-23 07:16:41,662 DEBUG : BROWSER_OUTPUT: 07:16:44 INFO - 2015-11-23 07:16:44,244 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:42996/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:42996/tests/kraken/driver.html?testName=audio-dft) 07:16:44 INFO - 2015-11-23 07:16:44,809 DEBUG : BROWSER_OUTPUT: RSS: Main: 167276544 07:16:44 INFO - 2015-11-23 07:16:44,810 DEBUG : BROWSER_OUTPUT: 07:16:47 INFO - 2015-11-23 07:16:47,667 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:42996/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:42996/tests/kraken/driver.html?testName=audio-fft) 07:16:48 INFO - 2015-11-23 07:16:48,220 DEBUG : BROWSER_OUTPUT: RSS: Main: 150339584 07:16:48 INFO - 2015-11-23 07:16:48,220 DEBUG : BROWSER_OUTPUT: 07:16:50 INFO - 2015-11-23 07:16:50,183 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:42996/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:42996/tests/kraken/driver.html?testName=audio-oscillator) 07:16:50 INFO - 2015-11-23 07:16:50,750 DEBUG : BROWSER_OUTPUT: RSS: Main: 155000832 07:16:50 INFO - 2015-11-23 07:16:50,750 DEBUG : BROWSER_OUTPUT: 07:16:52 INFO - 2015-11-23 07:16:52,883 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:42996/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:42996/tests/kraken/driver.html?testName=imaging-gaussian-blur) 07:16:53 INFO - 2015-11-23 07:16:53,448 DEBUG : BROWSER_OUTPUT: RSS: Main: 156786688 07:16:53 INFO - 2015-11-23 07:16:53,449 DEBUG : BROWSER_OUTPUT: 07:16:56 INFO - 2015-11-23 07:16:56,332 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:42996/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:42996/tests/kraken/driver.html?testName=imaging-darkroom) 07:16:56 INFO - 2015-11-23 07:16:56,905 DEBUG : BROWSER_OUTPUT: RSS: Main: 155488256 07:16:56 INFO - 2015-11-23 07:16:56,905 DEBUG : BROWSER_OUTPUT: 07:17:00 INFO - 2015-11-23 07:17:00,251 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:42996/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:42996/tests/kraken/driver.html?testName=imaging-desaturate) 07:17:00 INFO - 2015-11-23 07:17:00,818 DEBUG : BROWSER_OUTPUT: RSS: Main: 156360704 07:17:00 INFO - 2015-11-23 07:17:00,818 DEBUG : BROWSER_OUTPUT: 07:17:03 INFO - 2015-11-23 07:17:03,628 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:42996/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:42996/tests/kraken/driver.html?testName=json-parse-financial) 07:17:04 INFO - 2015-11-23 07:17:04,195 DEBUG : BROWSER_OUTPUT: RSS: Main: 158052352 07:17:04 INFO - 2015-11-23 07:17:04,195 DEBUG : BROWSER_OUTPUT: 07:17:05 INFO - 2015-11-23 07:17:05,742 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:42996/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:42996/tests/kraken/driver.html?testName=json-stringify-tinderbox) 07:17:06 INFO - 2015-11-23 07:17:06,303 DEBUG : BROWSER_OUTPUT: RSS: Main: 164253696 07:17:06 INFO - 2015-11-23 07:17:06,303 DEBUG : BROWSER_OUTPUT: 07:17:08 INFO - 2015-11-23 07:17:08,094 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:42996/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:42996/tests/kraken/driver.html?testName=stanford-crypto-aes) 07:17:08 INFO - 2015-11-23 07:17:08,688 DEBUG : BROWSER_OUTPUT: RSS: Main: 163139584 07:17:08 INFO - 2015-11-23 07:17:08,688 DEBUG : BROWSER_OUTPUT: 07:17:10 INFO - 2015-11-23 07:17:10,739 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:42996/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:42996/tests/kraken/driver.html?testName=stanford-crypto-ccm) 07:17:11 INFO - 2015-11-23 07:17:11,308 DEBUG : BROWSER_OUTPUT: RSS: Main: 169607168 07:17:11 INFO - 2015-11-23 07:17:11,308 DEBUG : BROWSER_OUTPUT: 07:17:13 INFO - 2015-11-23 07:17:13,710 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:42996/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:42996/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 07:17:14 INFO - 2015-11-23 07:17:14,291 DEBUG : BROWSER_OUTPUT: RSS: Main: 179142656 07:17:14 INFO - 2015-11-23 07:17:14,292 DEBUG : BROWSER_OUTPUT: 07:17:16 INFO - 2015-11-23 07:17:16,850 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:42996/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:42996/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 07:17:17 INFO - 2015-11-23 07:17:17,423 DEBUG : BROWSER_OUTPUT: RSS: Main: 178507776 07:17:17 INFO - 2015-11-23 07:17:17,423 DEBUG : BROWSER_OUTPUT: 07:17:19 INFO - 2015-11-23 07:17:19,092 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:42996/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:42996/tests/kraken/driver.html?testName=ai-astar) 07:17:19 INFO - 2015-11-23 07:17:19,338 DEBUG : BROWSER_OUTPUT: RSS: Main: 236724224 07:17:19 INFO - 2015-11-23 07:17:19,338 DEBUG : BROWSER_OUTPUT: 07:17:19 INFO - 2015-11-23 07:17:19,341 DEBUG : BROWSER_OUTPUT: __start_tp_report 07:17:19 INFO - 2015-11-23 07:17:19,341 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 07:17:19 INFO - 2015-11-23 07:17:19,342 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 07:17:19 INFO - 2015-11-23 07:17:19,342 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 07:17:19 INFO - 2015-11-23 07:17:19,342 DEBUG : BROWSER_OUTPUT: |0;ai-astar;110;109;104;109;111;111;97;109;113;111 07:17:19 INFO - 2015-11-23 07:17:19,342 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;149;131;151;161;124;151;147;124;172;127 07:17:19 INFO - 2015-11-23 07:17:19,342 DEBUG : BROWSER_OUTPUT: |2;audio-dft;160;159;160;161;160;159;158;163;160;161 07:17:19 INFO - 2015-11-23 07:17:19,342 DEBUG : BROWSER_OUTPUT: |3;audio-fft;72;72;84;95;73;71;72;101;93;71 07:17:19 INFO - 2015-11-23 07:17:19,342 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;89;90;133;90;91;90;130;89;90;132 07:17:19 INFO - 2015-11-23 07:17:19,342 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;109;109;109;110;109;109;110;109;110;109 07:17:19 INFO - 2015-11-23 07:17:19,343 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;145;145;146;145;145;145;145;145;145;145 07:17:19 INFO - 2015-11-23 07:17:19,343 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;95;98;96;97;95;96;97;95;96;95 07:17:19 INFO - 2015-11-23 07:17:19,343 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;58;57;57;57;57;58;57;64;55;56 07:17:19 INFO - 2015-11-23 07:17:19,343 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;67;68;68;69;68;69;69;68;68;68 07:17:19 INFO - 2015-11-23 07:17:19,343 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;83;85;84;84;84;85;84;83;84;85 07:17:19 INFO - 2015-11-23 07:17:19,343 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;123;122;114;117;122;118;116;120;126;120 07:17:19 INFO - 2015-11-23 07:17:19,343 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;144;141;158;150;151;141;153;150;153;139 07:17:19 INFO - 2015-11-23 07:17:19,344 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;66;68;68;68;65;66;68;65;66;66 07:17:19 INFO - 2015-11-23 07:17:19,344 DEBUG : BROWSER_OUTPUT: __end_tp_report 07:17:19 INFO - 2015-11-23 07:17:19,344 DEBUG : BROWSER_OUTPUT: __start_cc_report 07:17:19 INFO - 2015-11-23 07:17:19,344 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,909 07:17:19 INFO - 2015-11-23 07:17:19,344 DEBUG : BROWSER_OUTPUT: __end_cc_report 07:17:19 INFO - 2015-11-23 07:17:19,344 DEBUG : BROWSER_OUTPUT: __startTimestamp1448291839339__endTimestamp 07:17:19 INFO - 2015-11-23 07:17:19,344 DEBUG : BROWSER_OUTPUT: 07:17:19 INFO - 2015-11-23 07:17:19,348 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 07:17:19 INFO - 2015-11-23 07:17:19,348 DEBUG : BROWSER_OUTPUT: Number of tests: 14 07:17:19 INFO - 2015-11-23 07:17:19,348 DEBUG : BROWSER_OUTPUT: 07:17:19 INFO - 2015-11-23 07:17:19,349 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:108.40 Median:111.00 stddev:4.65 (4.2%) stddev-sans-first:4.89 07:17:19 INFO - 2015-11-23 07:17:19,349 DEBUG : BROWSER_OUTPUT: Values: 110.0 109.0 104.0 109.0 111.0 111.0 97.0 109.0 113.0 111.0 07:17:19 INFO - 2015-11-23 07:17:19,349 DEBUG : BROWSER_OUTPUT: 07:17:19 INFO - 2015-11-23 07:17:19,349 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:143.70 Median:150.00 stddev:16.54 (11.0%) stddev-sans-first:17.43 07:17:19 INFO - 2015-11-23 07:17:19,349 DEBUG : BROWSER_OUTPUT: Values: 149.0 131.0 151.0 161.0 124.0 151.0 147.0 124.0 172.0 127.0 07:17:19 INFO - 2015-11-23 07:17:19,349 DEBUG : BROWSER_OUTPUT: 07:17:19 INFO - 2015-11-23 07:17:19,349 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:160.10 Median:160.00 stddev:1.37 (0.9%) stddev-sans-first:1.45 07:17:19 INFO - 2015-11-23 07:17:19,349 DEBUG : BROWSER_OUTPUT: Values: 160.0 159.0 160.0 161.0 160.0 159.0 158.0 163.0 160.0 161.0 07:17:19 INFO - 2015-11-23 07:17:19,349 DEBUG : BROWSER_OUTPUT: 07:17:19 INFO - 2015-11-23 07:17:19,350 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:80.40 Median:72.50 stddev:11.80 (16.3%) stddev-sans-first:12.11 07:17:19 INFO - 2015-11-23 07:17:19,350 DEBUG : BROWSER_OUTPUT: Values: 72.0 72.0 84.0 95.0 73.0 71.0 72.0 101.0 93.0 71.0 07:17:19 INFO - 2015-11-23 07:17:19,350 DEBUG : BROWSER_OUTPUT: 07:17:19 INFO - 2015-11-23 07:17:19,350 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:102.40 Median:90.00 stddev:20.22 (22.5%) stddev-sans-first:20.85 07:17:19 INFO - 2015-11-23 07:17:19,350 DEBUG : BROWSER_OUTPUT: Values: 89.0 90.0 133.0 90.0 91.0 90.0 130.0 89.0 90.0 132.0 07:17:19 INFO - 2015-11-23 07:17:19,350 DEBUG : BROWSER_OUTPUT: 07:17:19 INFO - 2015-11-23 07:17:19,350 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:109.30 Median:109.00 stddev:0.48 (0.4%) stddev-sans-first:0.50 07:17:19 INFO - 2015-11-23 07:17:19,350 DEBUG : BROWSER_OUTPUT: Values: 109.0 109.0 109.0 110.0 109.0 109.0 110.0 109.0 110.0 109.0 07:17:19 INFO - 2015-11-23 07:17:19,350 DEBUG : BROWSER_OUTPUT: 07:17:19 INFO - 2015-11-23 07:17:19,351 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:145.10 Median:145.00 stddev:0.32 (0.2%) stddev-sans-first:0.33 07:17:19 INFO - 2015-11-23 07:17:19,351 DEBUG : BROWSER_OUTPUT: Values: 145.0 145.0 146.0 145.0 145.0 145.0 145.0 145.0 145.0 145.0 07:17:19 INFO - 2015-11-23 07:17:19,351 DEBUG : BROWSER_OUTPUT: 07:17:19 INFO - 2015-11-23 07:17:19,351 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:96.00 Median:96.00 stddev:1.05 (1.1%) stddev-sans-first:1.05 07:17:19 INFO - 2015-11-23 07:17:19,351 DEBUG : BROWSER_OUTPUT: Values: 95.0 98.0 96.0 97.0 95.0 96.0 97.0 95.0 96.0 95.0 07:17:19 INFO - 2015-11-23 07:17:19,352 DEBUG : BROWSER_OUTPUT: 07:17:19 INFO - 2015-11-23 07:17:19,352 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:57.60 Median:57.00 stddev:2.41 (4.2%) stddev-sans-first:2.55 07:17:19 INFO - 2015-11-23 07:17:19,352 DEBUG : BROWSER_OUTPUT: Values: 58.0 57.0 57.0 57.0 57.0 58.0 57.0 64.0 55.0 56.0 07:17:19 INFO - 2015-11-23 07:17:19,352 DEBUG : BROWSER_OUTPUT: 07:17:19 INFO - 2015-11-23 07:17:19,352 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:68.20 Median:68.00 stddev:0.63 (0.9%) stddev-sans-first:0.50 07:17:19 INFO - 2015-11-23 07:17:19,352 DEBUG : BROWSER_OUTPUT: Values: 67.0 68.0 68.0 69.0 68.0 69.0 69.0 68.0 68.0 68.0 07:17:19 INFO - 2015-11-23 07:17:19,352 DEBUG : BROWSER_OUTPUT: 07:17:19 INFO - 2015-11-23 07:17:19,352 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:84.10 Median:84.00 stddev:0.74 (0.9%) stddev-sans-first:0.67 07:17:19 INFO - 2015-11-23 07:17:19,352 DEBUG : BROWSER_OUTPUT: Values: 83.0 85.0 84.0 84.0 84.0 85.0 84.0 83.0 84.0 85.0 07:17:19 INFO - 2015-11-23 07:17:19,352 DEBUG : BROWSER_OUTPUT: 07:17:19 INFO - 2015-11-23 07:17:19,352 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:119.80 Median:121.00 stddev:3.61 (3.0%) stddev-sans-first:3.64 07:17:19 INFO - 2015-11-23 07:17:19,353 DEBUG : BROWSER_OUTPUT: Values: 123.0 122.0 114.0 117.0 122.0 118.0 116.0 120.0 126.0 120.0 07:17:19 INFO - 2015-11-23 07:17:19,353 DEBUG : BROWSER_OUTPUT: 07:17:19 INFO - 2015-11-23 07:17:19,353 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:148.00 Median:150.50 stddev:6.34 (4.2%) stddev-sans-first:6.56 07:17:19 INFO - 2015-11-23 07:17:19,353 DEBUG : BROWSER_OUTPUT: Values: 144.0 141.0 158.0 150.0 151.0 141.0 153.0 150.0 153.0 139.0 07:17:19 INFO - 2015-11-23 07:17:19,353 DEBUG : BROWSER_OUTPUT: 07:17:19 INFO - 2015-11-23 07:17:19,353 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.60 Median:67.00 stddev:1.26 (1.9%) stddev-sans-first:1.32 07:17:19 INFO - 2015-11-23 07:17:19,353 DEBUG : BROWSER_OUTPUT: Values: 66.0 68.0 68.0 68.0 65.0 66.0 68.0 65.0 66.0 66.0 07:17:19 INFO - 2015-11-23 07:17:19,353 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 07:17:19 INFO - 2015-11-23 07:17:19,353 DEBUG : BROWSER_OUTPUT: 07:17:20 INFO - 2015-11-23 07:17:20,165 INFO : Browser exited with error code: 0 07:17:20 INFO - 2015-11-23 07:17:20,216 INFO : Completed test kraken (00:00:58) 07:17:20 INFO - 2015-11-23 07:17:20,216 INFO : Starting test v8_7 07:17:20 INFO - 2015-11-23 07:17:20,216 DEBUG : operating with platform_type : linux_ 07:17:20 INFO - 2015-11-23 07:17:20,216 INFO : Initialising browser for v8_7 test... 07:17:20 INFO - 2015-11-23 07:17:20,222 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpmIEP64/profile http://localhost:42996/getInfo.html 07:17:23 INFO - 2015-11-23 07:17:23,935 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 07:17:23 INFO - 2015-11-23 07:17:23,935 DEBUG : BROWSER_OUTPUT: colorDepth:24 07:17:23 INFO - 2015-11-23 07:17:23,935 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 07:17:23 INFO - 2015-11-23 07:17:23,936 DEBUG : BROWSER_OUTPUT: __metrics 07:17:24 INFO - 2015-11-23 07:17:24,078 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:17:25 INFO - 2015-11-23 07:17:25,290 INFO : Browser initialized. 07:17:25 INFO - 2015-11-23 07:17:25,291 INFO : Running cycle 1/1 for v8_7 test... 07:17:25 INFO - 2015-11-23 07:17:25,291 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpmIEP64/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 07:17:37 INFO - 2015-11-23 07:17:37,066 DEBUG : BROWSER_OUTPUT: RSS: Main: 142364672 07:17:37 INFO - 2015-11-23 07:17:37,066 DEBUG : BROWSER_OUTPUT: 07:17:58 INFO - 2015-11-23 07:17:58,515 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:42996/tests/v8_7/run.html (next: http://localhost:42996/tests/v8_7/run.html) 07:17:58 INFO - 2015-11-23 07:17:58,773 DEBUG : BROWSER_OUTPUT: RSS: Main: 618446848 07:17:58 INFO - 2015-11-23 07:17:58,773 DEBUG : BROWSER_OUTPUT: 07:17:58 INFO - 2015-11-23 07:17:58,773 DEBUG : BROWSER_OUTPUT: __start_tp_report 07:17:58 INFO - 2015-11-23 07:17:58,773 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 07:17:58 INFO - 2015-11-23 07:17:58,773 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 07:17:58 INFO - 2015-11-23 07:17:58,773 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 07:17:58 INFO - 2015-11-23 07:17:58,774 DEBUG : BROWSER_OUTPUT: |0;Richards;163.3453119895459 07:17:58 INFO - 2015-11-23 07:17:58,774 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;194.55252918287937 07:17:58 INFO - 2015-11-23 07:17:58,774 DEBUG : BROWSER_OUTPUT: |2;Encrypt;286.5329512893983 07:17:58 INFO - 2015-11-23 07:17:58,774 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5030.150753768844 07:17:58 INFO - 2015-11-23 07:17:58,774 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1104.9723756906078 07:17:58 INFO - 2015-11-23 07:17:58,774 DEBUG : BROWSER_OUTPUT: |5;Earley;776.3975155279503 07:17:58 INFO - 2015-11-23 07:17:58,774 DEBUG : BROWSER_OUTPUT: |6;Boyer;11764.70588235294 07:17:58 INFO - 2015-11-23 07:17:58,774 DEBUG : BROWSER_OUTPUT: |7;RegExp;25974.358974358973 07:17:58 INFO - 2015-11-23 07:17:58,774 DEBUG : BROWSER_OUTPUT: |8;Splay;649.772579597141 07:17:58 INFO - 2015-11-23 07:17:58,774 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4835.748792270531 07:17:58 INFO - 2015-11-23 07:17:58,774 DEBUG : BROWSER_OUTPUT: __end_tp_report 07:17:58 INFO - 2015-11-23 07:17:58,774 DEBUG : BROWSER_OUTPUT: __startTimestamp1448291878766__endTimestamp 07:17:58 INFO - 2015-11-23 07:17:58,774 DEBUG : BROWSER_OUTPUT: 07:17:58 INFO - 2015-11-23 07:17:58,774 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 07:17:58 INFO - 2015-11-23 07:17:58,774 DEBUG : BROWSER_OUTPUT: Number of tests: 10 07:17:58 INFO - 2015-11-23 07:17:58,775 DEBUG : BROWSER_OUTPUT: 07:17:58 INFO - 2015-11-23 07:17:58,775 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:163.35 Median:163.35 stddev:0.00 (0.0%) 07:17:58 INFO - 2015-11-23 07:17:58,775 DEBUG : BROWSER_OUTPUT: Values: 163.3 07:17:58 INFO - 2015-11-23 07:17:58,775 DEBUG : BROWSER_OUTPUT: 07:17:58 INFO - 2015-11-23 07:17:58,775 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:194.55 Median:194.55 stddev:0.00 (0.0%) 07:17:58 INFO - 2015-11-23 07:17:58,775 DEBUG : BROWSER_OUTPUT: Values: 194.6 07:17:58 INFO - 2015-11-23 07:17:58,775 DEBUG : BROWSER_OUTPUT: 07:17:58 INFO - 2015-11-23 07:17:58,775 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:286.53 Median:286.53 stddev:0.00 (0.0%) 07:17:58 INFO - 2015-11-23 07:17:58,775 DEBUG : BROWSER_OUTPUT: Values: 286.5 07:17:58 INFO - 2015-11-23 07:17:58,775 DEBUG : BROWSER_OUTPUT: 07:17:58 INFO - 2015-11-23 07:17:58,775 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5030.15 Median:5030.15 stddev:0.00 (0.0%) 07:17:58 INFO - 2015-11-23 07:17:58,775 DEBUG : BROWSER_OUTPUT: Values: 5030.2 07:17:58 INFO - 2015-11-23 07:17:58,775 DEBUG : BROWSER_OUTPUT: 07:17:58 INFO - 2015-11-23 07:17:58,775 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1104.97 Median:1104.97 stddev:0.00 (0.0%) 07:17:58 INFO - 2015-11-23 07:17:58,775 DEBUG : BROWSER_OUTPUT: Values: 1105.0 07:17:58 INFO - 2015-11-23 07:17:58,775 DEBUG : BROWSER_OUTPUT: 07:17:58 INFO - 2015-11-23 07:17:58,776 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:776.40 Median:776.40 stddev:0.00 (0.0%) 07:17:58 INFO - 2015-11-23 07:17:58,776 DEBUG : BROWSER_OUTPUT: Values: 776.4 07:17:58 INFO - 2015-11-23 07:17:58,776 DEBUG : BROWSER_OUTPUT: 07:17:58 INFO - 2015-11-23 07:17:58,776 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:11764.71 Median:11764.71 stddev:0.00 (0.0%) 07:17:58 INFO - 2015-11-23 07:17:58,776 DEBUG : BROWSER_OUTPUT: Values: 11764.7 07:17:58 INFO - 2015-11-23 07:17:58,776 DEBUG : BROWSER_OUTPUT: 07:17:58 INFO - 2015-11-23 07:17:58,776 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:25974.36 Median:25974.36 stddev:0.00 (0.0%) 07:17:58 INFO - 2015-11-23 07:17:58,776 DEBUG : BROWSER_OUTPUT: Values: 25974.4 07:17:58 INFO - 2015-11-23 07:17:58,776 DEBUG : BROWSER_OUTPUT: 07:17:58 INFO - 2015-11-23 07:17:58,776 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:649.77 Median:649.77 stddev:0.00 (0.0%) 07:17:58 INFO - 2015-11-23 07:17:58,776 DEBUG : BROWSER_OUTPUT: Values: 649.8 07:17:58 INFO - 2015-11-23 07:17:58,776 DEBUG : BROWSER_OUTPUT: 07:17:58 INFO - 2015-11-23 07:17:58,776 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4835.75 Median:4835.75 stddev:0.00 (0.0%) 07:17:58 INFO - 2015-11-23 07:17:58,776 DEBUG : BROWSER_OUTPUT: Values: 4835.7 07:17:58 INFO - 2015-11-23 07:17:58,776 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 07:17:58 INFO - 2015-11-23 07:17:58,776 DEBUG : BROWSER_OUTPUT: 07:17:59 INFO - 2015-11-23 07:17:59,589 INFO : Browser exited with error code: 0 07:17:59 INFO - 2015-11-23 07:17:59,601 INFO : Completed test v8_7 (00:00:39) 07:17:59 INFO - 2015-11-23 07:17:59,731 INFO : Completed test suite (00:20:10) 07:17:59 INFO - 2015-11-23 07:17:59,731 DEBUG : Working with test: dromaeo_css 07:17:59 INFO - 2015-11-23 07:17:59,731 DEBUG : Generating results file: dromaeo_css 07:17:59 INFO - 2015-11-23 07:17:59,732 DEBUG : Working with test: kraken 07:17:59 INFO - 2015-11-23 07:17:59,733 DEBUG : Generating results file: kraken 07:17:59 INFO - 2015-11-23 07:17:59,733 INFO : javascript benchmark 07:17:59 INFO - 2015-11-23 07:17:59,733 DEBUG : Working with test: v8_7 07:17:59 INFO - 2015-11-23 07:17:59,733 DEBUG : Generating results file: v8_7 07:17:59 INFO - 2015-11-23 07:17:59,734 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 07:17:59 INFO - 2015-11-23 07:17:59,783 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,201,35]] 07:17:59 INFO - 2015-11-23 07:17:59,783 DEBUG : process_Request line: dromaeo_css 7039.60 graph.html#tests=[[72,201,35]] 07:17:59 INFO - 2015-11-23 07:17:59,783 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 07:17:59 INFO - 2015-11-23 07:17:59,814 DEBUG : process_Request line: kraken 1489.70 graph.html#tests=[[232,201,35]] 07:17:59 INFO - 2015-11-23 07:17:59,814 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 07:17:59 INFO - 2015-11-23 07:17:59,844 DEBUG : process_Request line: v8_7 20978.14 graph.html#tests=[[230,201,35]] 07:17:59 INFO - 2015-11-23 07:17:59,846 INFO : javascript benchmark 07:17:59 INFO - 2015-11-23 07:17:59,849 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3184.920376990575, 3241.5623890774737, 3245.8863939762114, 3254.9837250813757, 3270.8855190068343, 5350.91973620396, 5424.810131645393, 5456.072467680494, 5476.151196564534, 5500.147477141045, 5290.629655924087, 5302.893942121155, 5312.574994000481, 5455.399906010346, 5539.307586551681, 4993.850184494462, 5017.448080711137, 5035.320231768719, 5090.974545127269, 5126.589872810185, 268.73857404021936, 4792.496787837279, 5026.246063090529, 5031.496850314976, 5076.086304465195, 4960.2559616057515, 4982.0, 5033.370828646419, 5071.188609822448, 5094.694318340893, 4905.656604037718, 4908.141075311842, 4911.803527858881, 4912.754362281871, 4956.281339205831, 4760.262159365304, 4870.147724148295, 4895.0944075345815, 4924.852254432372, 4929.926051109236, 5089.185730283137, 5186.040582492214, 5218.373795144569, 5218.947810521922, 5251.921221181686, 5790.565707571949, 5791.536677065825, 5792.102224155221, 5794.855128621818, 5850.297964244275, 5559.110542313251, 5635.915461268084, 5847.941520584783, 5854.18041474194, 5878.764849406019, 5577.553795696334, 5577.8605534861545, 5579.581531385163, 5583.162525621149, 5601.859953501195, 6066.908996365058, 6068.726907289182, 6078.696065196811, 6079.361667024988, 6133.26400831903, 5730.08318669011, 5788.218590490314, 5788.594798364074, 5855.063189889597, 5933.406659334032, 5879.559033072536, 5879.7060146993335, 5893.764249430061, 6033.064874944391, 6071.392860713893, 5837.6497410155525, 5841.094630332305, 5842.970785146047, 5855.151003104611, 5873.383294754075, 5642.520385767174, 5742.626729262584, 5820.156077368758, 5822.446867547576, 5839.562032847553, 4512.2329204035395, 4525.660575456788, 4555.020670555847, 4600.746958917225, 4606.424196975311, 4048.554658987509, 4055.9391609125296, 4059.167870586523, 4064.451299074587, 4092.242935057024, 5257.342832145981, 5365.436629153961, 5445.210444485528, 5520.171974203821, 5526.640768350125, 5894.115882617642, 5909.438603332676, 5914.319853216849, 5916.994111001054, 6030.819075427744, 5510.421405752339, 5521.365043020024, 5526.364468086141, 5532.612717109763, 5548.72256387179, 4872.80508779652, 4991.675541089818, 5021.949780502221, 5117.462666420047, 5117.641765076483, 6127.387261273837, 6146.78486252979, 6157.96921015401, 6162.845928851814, 6169.259688837278, 5957.344692083954, 5958.314793798769, 5960.105984102419, 5961.731722072604, 5962.940370596239, 5870.236869206976, 6027.246594175728, 6040.214772079602, 6044.942135126424, 6117.200569274211, 5777.884442311214, 5783.855403614775, 5787.0, 5807.157962095557, 5903.409659034062, 5817.389174136655, 5838.357780644211, 5879.059350503899, 5884.0, 5887.411258874078, 5626.971865140648, 5631.605787594829, 5702.857428564319, 5745.224394706661, 5754.769809207585, 5691.117876729114, 5692.943070569241, 5694.943050569441, 5709.628874123168, 5729.1119876419225, 5576.275084239023, 5582.302212223472, 5587.944120558743, 5590.385057643574, 5595.160725891149, 5613.129964855454, 5717.828465146053, 5720.256366672306, 5768.596198266249, 5769.769209231584, 5693.800716974886, 5718.742656580381, 5723.370429252862, 5728.770849165987, 5760.423957604206], "unit": "ms", "name": "dojo.html", "value": 5364.928109566225}, {"lowerIsBetter": false, "replicates": [580.0747807247442, 581.8603535151564, 589.884972430376, 591.110378879786, 601.8375038739538, 31843.840780796094, 38587.0, 38679.61320386795, 38874.99999999993, 39034.804825975865, 40545.797271013675, 40878.99999999993, 40955.18089638205, 40995.38506922399, 41033.79483102588, 7679.539227646331, 7806.804829879242, 8626.827463450743, 8817.647294108228, 8823.95588022059, 10517.84223236652, 10764.407957562331, 10774.353538787698, 10777.83833242502, 10798.67603971882, 10402.0, 10504.842427363596, 10513.894861051407, 10518.0, 10518.526666300035, 7891.684332626717, 8008.119106898236, 8063.153368896299, 10417.479126043705, 10509.106725928228, 10187.643432479828, 10337.948310258476, 10338.483075846252, 10338.948305258426, 10342.276040677156, 40975.0, 41206.79396603028, 41445.171096578204, 41473.377899331535, 41509.169816603804, 3448.0345503259127, 3471.583409990792, 3710.239400922804, 3899.961000389988, 4026.45642838216, 30647.38705225905, 30767.230819229473, 31121.533177002362, 31652.366952661047, 32046.83976580102, 3941.487606611151, 3957.2679054374744, 3977.5425826030087, 3989.3617021276455, 4047.5547689754103, 277383.0, 277952.0, 278043.0, 278316.0, 278875.0, 53371.19943200855, 54429.0, 60079.0, 67632.32367676261, 68829.31170688229, 62163.37836621666, 62333.0, 62450.68774656098, 62532.0, 62656.686716566124, 15882.920585397, 16030.358785648443, 16128.435504757277, 16133.354665813471, 16140.112293823953, 12211.75576488483, 12274.570390036484, 12368.938155309166, 12373.319467429377, 12545.811812822814, 20312.898435507726, 20420.285290014777, 20433.69349459759, 20649.380518584465, 20658.380248592566, 7029.472789540805, 7265.4187664986675, 7305.269473052652, 7313.817154571072, 7353.1911489736085, 940.47333493244, 1021.3310281765456, 1024.8975102489692, 1072.4048153275007, 1083.8482612434266, 30936.535951960737, 31751.919692849035, 31843.681563184535, 31939.520907186412, 32118.678813212035, 999.3853779925294, 1005.703317521333, 1023.5854478936043, 1056.8837427882927, 1083.5394957143183, 14933.850661493247, 14991.775123373158, 15016.849831501546, 15077.170755608548, 15301.617459563377, 329666.0, 332963.0, 335515.0, 335889.0, 336065.0, 53733.46266537363, 53806.0, 53911.0, 53998.19002714963, 54190.0, 1360.190686541526, 1370.8012338210904, 1376.8072469854228, 1378.221304962713, 1390.986090139106, 26143.346416339744, 28316.292092697848, 28791.712082878905, 29247.268818279714, 29275.268118297212, 50116.0, 50604.74697626635, 50624.74687626538, 50703.74648126736, 50728.22451214337, 283915.0, 284972.0, 285070.0, 286285.0, 287250.0, 28386.716132838406, 28806.567901481074, 31127.53308700326, 32473.51289730703, 32874.83562582172, 39202.01994950149, 39383.21233575255, 40469.0, 40736.3889541663, 43620.56379436165, 36327.45508817317, 36756.0, 36996.0, 39467.40798887962, 39929.40105898472, 29334.0, 34614.653853461146, 35580.64419355877, 36953.076173094814, 37570.436443452825, 33512.83243583766, 33789.66210337865, 35705.15594149268, 35756.28487430289, 36391.0, 29724.702752972193, 31344.52983205208, 31641.8417907909, 31781.682183177873, 31854.203644908135, 23607.40981475477, 23744.287671369886, 23783.643245350988, 23983.160589379288, 24227.878860605586], "unit": "ms", "name": "ext.html", "value": 18978.056383156167}, {"lowerIsBetter": false, "replicates": [355.1901664205612, 356.50623885918003, 358.81769569269255, 358.9982050089751, 360.18597968590984, 13670.111442756213, 13946.23295718735, 16610.66778664426, 16913.40803071891, 17588.824111758877, 15324.770128448083, 15931.283092260846, 16228.269727862245, 16391.59021024475, 16400.507984760447, 5247.449017853118, 5367.194920761878, 5369.838904832842, 5372.758225879845, 5375.543078838304, 4031.173609410064, 4147.232761939036, 5303.787848486056, 5337.11937530307, 5921.911171332434, 5980.73086711099, 6006.939930600682, 6034.943884820161, 6038.33578306386, 6042.848928776772, 5816.185733997244, 5925.08161235005, 5932.169496270504, 5943.821685349447, 5953.464188223059, 5138.484147176555, 5208.348956380452, 5208.453112423217, 5211.42674305826, 5233.084210263227, 20335.49161270965, 20426.38720838377, 20637.17451301946, 20663.380098597067, 20709.378718638465, 2016.4656366063004, 2133.615949129156, 2146.6350720377573, 2288.1762565476415, 2660.5344064788583, 8990.325725570543, 9324.440533568008, 9356.71929842099, 12909.67725806853, 13238.27189504577, 1787.34761811939, 1806.7741532308462, 1847.2057015483338, 1887.7262796894374, 1905.1522072677665, 58368.70815645937, 61598.38401615971, 61821.38178618201, 63981.68009159924, 65825.67087164581, 9530.571124299424, 9870.851937220947, 9955.303128780915, 9974.40153590787, 10017.549210285555, 13306.201627902357, 13315.40080696371, 13317.866821331663, 13332.800007999887, 13338.19970801755, 7411.85176296471, 7411.925880741232, 7445.25547445262, 7451.627418629047, 7457.32884040439, 7202.1357437106835, 7213.531120477152, 7225.5664660120565, 7227.602481863443, 7277.3086556777025, 4341.82632694695, 4354.716943398669, 4358.629516491071, 4359.324304732771, 4382.912341753147, 1576.3064251729202, 1640.7620894970162, 1755.5260079778388, 1806.5483629092728, 1816.8728189026642, 897.9775505612412, 921.166344458253, 922.5663937949154, 1041.8176819056634, 1044.0603456888862, 16103.27535260916, 16229.350825966829, 16295.755563666555, 16625.0, 16645.33418663264, 890.4345740454858, 925.6991477769752, 927.4759760735163, 949.9620015199453, 991.1030517381781, 7715.807104822425, 9007.549622518847, 9105.271578273721, 9534.237261019101, 9741.123298903132, 533269.0, 536125.0, 553194.0, 557462.0, 565205.0, 80272.0, 83519.5824020876, 83651.0, 83722.16277837266, 84264.57867710623, 1052.3580615824342, 1078.9946050269698, 1098.6923661374828, 1136.3068528197794, 1139.7549526851767, 15011.924940375227, 15025.549233523012, 15086.24568771535, 15212.239388030333, 15650.686986260438, 33300.333993320484, 33551.664483354856, 34187.14532136716, 34967.475487867196, 35734.4639830408, 42893.571064290205, 42981.0, 43770.56229437665, 44196.0, 45375.546244538455, 9449.622015119317, 9466.857997130186, 9702.85445718329, 9703.690001849942, 9718.271129665161, 12805.8079128815, 17348.739768903728, 17374.0, 17922.64154716872, 18041.548961276072, 14448.638784030483, 14498.275086245856, 14744.55766327012, 14879.330430130887, 14890.478833240784, 13939.860601394263, 13962.37169327403, 14491.660796317276, 14610.415583376545, 14645.0, 14665.41338346497, 14744.336504857522, 14804.629884252548, 15072.773908391164, 15389.692206156038, 9443.197328227177, 9512.619495220113, 9556.713298601053, 9565.378250413702, 9566.426014439156, 14300.499482518062, 14300.856991429953, 14542.709145817236, 14669.633259168606, 15104.39582416691], "unit": "ms", "name": "jquery.html", "value": 8891.813583991667}, {"lowerIsBetter": false, "replicates": [1262.3372729317114, 1700.5493544210785, 1739.9043052632107, 1767.6376342849717, 1772.3796671165094, 6748.527603067787, 7369.410447164228, 7435.921791340253, 7445.739399121032, 7470.626468676572, 7621.657025433855, 7742.535447873118, 7750.496217745843, 7768.88346674799, 7776.650050747716, 2062.9896850515725, 2107.725995620567, 2274.727032756063, 2300.9769902300973, 2324.651302304651, 2336.7663233676667, 2340.595642614435, 2342.367560758594, 2344.132670911765, 2346.296111166643, 2249.403907964391, 2288.347820871052, 2289.2445492987276, 2292.7592602776717, 2293.9541209175804, 1757.7627020352218, 1791.3819732192374, 2244.259394399844, 2295.6556516522487, 2296.81625469962, 2311.433698743802, 2318.0, 2332.8017118544944, 2345.5074434368803, 2384.2966324934014, 7713.267239612228, 7797.337226335769, 7801.843963120706, 7805.1804560520895, 7809.414293927921, 4606.792694328763, 4667.509911459316, 4672.929906051412, 4705.176594096054, 4705.976470117627, 3005.6242969628797, 3040.437519058959, 3067.708567686066, 3091.1499337682094, 3192.2817366092677, 981.087588542655, 1002.6691191906654, 1006.4263369879171, 1026.015025575441, 1053.9104176145038, 10945.83581246282, 10966.670999870017, 10969.670909872717, 10985.066269367113, 10996.945015275032, 4124.546299907008, 4255.702100852973, 4302.569743025735, 4303.440552728125, 4303.462067241595, 9328.533573321307, 9334.579943902405, 9336.859947100798, 9340.439573625605, 9341.719748407559, 4690.742009189459, 4712.575868171881, 4754.95245047552, 4755.405574303212, 4756.9762151189025, 4297.849575264913, 4335.653147748236, 4340.131973605292, 4349.217140914602, 4349.28236840924, 3741.6819570336284, 3776.4901738264984, 3783.6783873370523, 3794.3739283018544, 3831.2912111259507, 1211.0311750599485, 1216.92698438094, 1221.4686611324103, 1230.5816022552197, 1232.3776492871043, 1071.844582535528, 1092.63396762084, 1093.4696672114019, 1221.328269451798, 1311.9212847229196, 7123.857522849514, 7141.89287160693, 7160.713571457188, 7164.068671072727, 7442.516236444614, 1099.0767755085767, 1118.6196693124214, 1118.6364431559775, 1125.3135587291745, 1138.7494751154732, 5681.375048744718, 5699.857503562361, 5731.226284451629, 5923.466887980103, 5938.168656388109, 9115.772105697411, 9388.389754665925, 9399.389039712534, 9409.153176214173, 9438.528073596293, 9134.086591340812, 9171.037041110587, 9290.256779457628, 9355.87729472454, 9367.344285899922, 7103.112110986127, 7104.893426598605, 7164.21193668696, 7165.462590305748, 7172.856542869218, 7004.579725216299, 7133.429325653831, 7145.321194486515, 7147.356737893615, 7183.928160718326, 8157.592120394075, 8450.281726053108, 8470.364722645703, 8472.406931514735, 8615.6984505542, 8537.701180458655, 8568.700095496628, 8654.0, 8704.0, 8754.956225218833, 6786.083878676315, 6846.554973926679, 6851.9657401712675, 6882.311768823078, 6898.8620227596175, 7597.848043039219, 7792.454528182972, 7844.607769611611, 7849.215078492105, 7849.411294153076, 6534.150560427114, 6948.478864085113, 6975.581465112109, 7088.220295767358, 7420.480566360303, 7015.649217539205, 7048.682809273698, 7069.575825450489, 7087.114110736158, 7103.360697537247, 7008.299170082951, 7051.330123638246, 7055.929440705732, 7079.929200707927, 7083.822904427225, 6167.907481387693, 6210.006398976142, 6214.471769899428, 6222.160008398808, 6233.314335423009, 6427.357264273535, 6429.485641148791, 6448.806535803933, 6449.032645103272, 6462.030695395728], "unit": "ms", "name": "mootools.html", "value": 4499.52759846432}, {"lowerIsBetter": false, "replicates": [331.57227176941745, 333.40154422811054, 338.6900985598178, 341.5491551152478, 346.98091604961735, 5802.042662960617, 5932.88134237315, 5959.553033522487, 5981.252343457062, 6046.697665116749, 5799.420057994198, 5952.523798096142, 5978.6412815231115, 5980.671063091529, 5996.340402555716, 4614.446266448014, 4633.490316065238, 4645.442546894377, 4647.86056418308, 4661.09108723799, 4455.086707225011, 4516.796744146505, 4566.634669226454, 4644.187267228222, 4652.930206046912, 4591.908161836761, 4594.931076033846, 4610.5850473457385, 4613.792379342921, 4616.538346165374, 4599.977000114995, 4608.907821843544, 4613.976930115345, 4622.884427889296, 4627.8611641650805, 4088.1619268050276, 4091.9386209206887, 4092.5498195198506, 4101.630853223224, 4104.651104656108, 5605.943940560583, 5709.543236541067, 5710.2862142232225, 5714.885702285931, 5718.885622287531, 5384.461553844623, 5391.137418013138, 5397.379301380352, 5402.567794576464, 5406.405295417501, 6121.081837724332, 6337.397947195009, 6338.936610633927, 6351.491880649537, 6354.364563543655, 4412.977935110304, 4424.557544245582, 4503.729776213405, 4517.570830771071, 4523.7285762854335, 6606.669666516703, 6624.569402988838, 6627.237867645186, 6627.469802415795, 6632.734690612418, 4633.351330813622, 4644.140833945731, 4649.651276154302, 4650.000249946278, 4650.95349046512, 4452.888677783081, 4565.885852853638, 4574.039451715177, 4697.389339385858, 4699.342092107107, 5272.578193744491, 5295.655782374133, 5300.337457817773, 5300.946990530122, 5305.62860599762, 6426.196725409324, 6428.389303016206, 6430.646314452656, 6432.388923052303, 6436.324185960407, 1593.1237819199625, 1629.413411171977, 1630.2174956021177, 1631.5023917705214, 1632.3470611755156, 1065.1532032034552, 1081.3944191252767, 1085.3976043296047, 1105.309181761399, 1112.5382966069153, 6102.4507794298725, 6114.633122012605, 6117.388261173847, 6119.296280927751, 6119.510439164945, 6539.50953678476, 6550.672466376662, 6554.80335589933, 6577.177852768404, 6596.901046484307, 5965.28416590012, 6088.178095957078, 6111.419415155553, 6114.144019837227, 6120.938790612036, 3555.2178520725397, 3594.658507441789, 3595.802230877327, 3596.730245231618, 3599.5140656011627, 6850.21222559412, 6851.623160726208, 6853.691583878737, 6856.760013399507, 6865.828354291083, 6628.469722422291, 6778.322167783281, 6782.660866956731, 6786.049953006583, 6801.591904485746, 6759.087523184406, 6837.658117094026, 6843.452523798084, 6845.281245469154, 6852.965735171392, 6350.841228969312, 6445.097686323825, 6507.089007538853, 6557.180352455943, 6590.538662293593, 6525.804225873231, 6588.155316511385, 6602.636854973022, 6614.867702646016, 6616.867662646817, 6888.896666550106, 6891.241963384124, 6891.655417229018, 6892.551984121016, 6894.069300644549, 4483.663725220556, 4530.501644819134, 4543.228141024937, 4565.7717114144825, 4574.085182963488, 6613.14029176204, 6616.636085015371, 6617.702203400955, 6622.63575503352, 6645.335466453316, 6461.676916154268, 6468.514861385321, 6469.676516174267, 6472.126262954629, 6474.741010359721, 6316.273628532594, 6446.484281257582, 6454.225492940877, 6490.123833282447, 6494.967525162344, 6361.968190159205, 6363.3000369958345, 6364.618122912455, 6380.457661098673, 6381.776637817654, 6491.188601424822, 6495.870082598227, 6501.122348483083, 6504.1219435375615, 6508.0, 6207.224096987877, 6345.111684364285, 6350.936490635035, 6356.141920840627, 6356.936430635819], "unit": "ms", "name": "prototype.html", "value": 4835.750373699021}, {"lowerIsBetter": false, "replicates": [747.7121308296307, 764.9311561959419, 840.8402403543326, 863.5595846118478, 898.04806904681, 13429.999999999987, 13718.245496497688, 13724.931375343109, 13740.244286564248, 13762.311884405777, 13122.803157952638, 13196.670083247924, 13210.603681889559, 13213.603591892235, 13221.471141154343, 662.8442316055723, 677.6239187251099, 798.3413683710933, 820.2248874813274, 823.0329362998483, 824.575343697996, 826.5990994367727, 832.5337810825927, 832.546262287052, 832.7460124661976, 700.530644468205, 850.3622283287534, 854.1031916487694, 856.575994882534, 857.8970523537184, 705.1221229569194, 708.2917082917083, 710.261328218652, 847.639753104928, 858.8797568340437, 634.8508100596356, 635.0569404434411, 636.2333388267127, 637.101686621861, 637.5186734015834, 13447.0, 13588.38852251651, 13658.795118073138, 13664.65838354039, 13685.521006764715, 12143.574974875837, 12775.552855650101, 13249.536266230733, 13267.734645307137, 13484.528041518499, 9390.671326503609, 9444.05559444057, 9989.0, 10304.96950304971, 10376.118029967462, 3605.6574625410544, 3660.103274697716, 3664.2305115925687, 3770.9057273568105, 3786.2238241160494, 43677.78161109206, 44021.11957760859, 44114.338284925754, 44300.11399772019, 44444.0, 9702.037229209483, 9787.119159275699, 9823.656172033945, 10018.148457381058, 10078.496075196212, 18901.7164742529, 18910.243590256236, 18936.526586835163, 18966.620667586572, 18979.620407592047, 7324.37742791858, 7454.813629659302, 7501.849963000818, 7575.659095340723, 7709.0, 4144.0, 4194.874153775391, 4198.685098617616, 4282.593153650399, 4317.501496707257, 3149.889753858604, 3163.731082857983, 3166.5566820645126, 3168.556402103707, 3184.331290429036, 544.7194694732216, 562.3785716782896, 568.7867049856304, 579.273012369482, 586.4838941731249, 611.4099893602695, 651.2900937977532, 660.4155322539491, 667.7395815631908, 679.6789854354483, 7856.25365590268, 8307.792305192419, 8398.664053437917, 8826.955865220762, 9106.544672766335, 497.5745737394548, 647.9546431749732, 658.6048370977471, 664.8470851704135, 679.8028571714148, 3603.837827297778, 4033.052232725307, 4074.7758873262255, 4155.376693495939, 4170.436991006175, 54456.0, 55316.0, 55427.72286138624, 55980.440195598334, 56055.0, 47583.52416475791, 48743.5125648746, 48873.0, 50498.24252636213, 50719.73200669939, 42591.36112958308, 43277.567224327984, 43542.56457435385, 43668.34497482604, 44007.0, 8166.918330816853, 8290.854572713642, 8292.834143316979, 8310.21052999964, 8450.281726053354, 33579.328413432086, 33747.156321091185, 34223.31553368968, 34486.3443435133, 34712.82643586766, 39676.60323396729, 41623.58376416318, 42686.0, 43019.56980430281, 43318.566814331454, 10512.106470950055, 10751.19366047534, 10955.466234726986, 11004.889951100387, 11071.391073491035, 11168.497417616065, 11553.82669259945, 11817.586384476503, 11999.880001200225, 12526.561570344995, 10892.128629709763, 10989.725256868642, 11026.614068507564, 11311.151663625425, 11408.201425900439, 10050.849237261593, 10447.529861156418, 10451.16390688728, 10481.737956551147, 10836.0, 9795.559199836167, 10795.784084318113, 10823.51294191779, 10982.0, 11220.831687524531, 8959.955200223958, 9112.134347237003, 9124.224440922597, 9142.954285228532, 9431.905680943102, 8254.42219044661, 8395.622197001272, 9076.954615226881, 9078.182963533049, 9115.863262051207], "unit": "ms", "name": "yui.html", "value": 6177.475976572093}], "name": "dromaeo_css", "value": 7039.5975469157}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [110.0, 109.0, 104.0, 109.0, 111.0, 111.0, 97.0, 109.0, 113.0, 111.0], "unit": "ms", "name": "ai-astar", "value": 108.4}, {"lowerIsBetter": true, "replicates": [149.0, 131.0, 151.0, 161.0, 124.0, 151.0, 147.0, 124.0, 172.0, 127.0], "unit": "ms", "name": "audio-beat-detection", "value": 143.7}, {"lowerIsBetter": true, "replicates": [160.0, 159.0, 160.0, 161.0, 160.0, 159.0, 158.0, 163.0, 160.0, 161.0], "unit": "ms", "name": "audio-dft", "value": 160.1}, {"lowerIsBetter": true, "replicates": [72.0, 72.0, 84.0, 95.0, 73.0, 71.0, 72.0, 101.0, 93.0, 71.0], "unit": "ms", "name": "audio-fft", "value": 80.4}, {"lowerIsBetter": true, "replicates": [89.0, 90.0, 133.0, 90.0, 91.0, 90.0, 130.0, 89.0, 90.0, 132.0], "unit": "ms", "name": "audio-oscillator", "value": 102.4}, {"lowerIsBetter": true, "replicates": [109.0, 109.0, 109.0, 110.0, 109.0, 109.0, 110.0, 109.0, 110.0, 109.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 109.3}, {"lowerIsBetter": true, "replicates": [145.0, 145.0, 146.0, 145.0, 145.0, 145.0, 145.0, 145.0, 145.0, 145.0], "unit": "ms", "name": "imaging-darkroom", "value": 145.1}, {"lowerIsBetter": true, "replicates": [95.0, 98.0, 96.0, 97.0, 95.0, 96.0, 97.0, 95.0, 96.0, 95.0], "unit": "ms", "name": "imaging-desaturate", "value": 96.0}, {"lowerIsBetter": true, "replicates": [58.0, 57.0, 57.0, 57.0, 57.0, 58.0, 57.0, 64.0, 55.0, 56.0], "unit": "ms", "name": "json-parse-financial", "value": 57.6}, {"lowerIsBetter": true, "replicates": [67.0, 68.0, 68.0, 69.0, 68.0, 69.0, 69.0, 68.0, 68.0, 68.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 68.2}, {"lowerIsBetter": true, "replicates": [83.0, 85.0, 84.0, 84.0, 84.0, 85.0, 84.0, 83.0, 84.0, 85.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 84.1}, {"lowerIsBetter": true, "replicates": [123.0, 122.0, 114.0, 117.0, 122.0, 118.0, 116.0, 120.0, 126.0, 120.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 119.8}, {"lowerIsBetter": true, "replicates": [144.0, 141.0, 158.0, 150.0, 151.0, 141.0, 153.0, 150.0, 153.0, 139.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 148.0}, {"lowerIsBetter": true, "replicates": [66.0, 68.0, 68.0, 68.0, 65.0, 66.0, 68.0, 65.0, 66.0, 66.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 66.6}], "name": "kraken", "value": 1489.6999999999998}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [163.3453119895459], "unit": "score", "name": "Richards", "value": 216.118844}, {"lowerIsBetter": false, "replicates": [194.55252918287937], "unit": "score", "name": "DeltaBlue", "value": 339.84651999999994}, {"lowerIsBetter": false, "replicates": [286.5329512893983], "unit": "score", "name": "Encrypt", "value": 928.97169}, {"lowerIsBetter": false, "replicates": [5030.150753768844], "unit": "score", "name": "Decrypt", "value": 52.91710189810189}, {"lowerIsBetter": false, "replicates": [1104.9723756906078], "unit": "score", "name": "RayTrace", "value": 669.6900450000003}, {"lowerIsBetter": false, "replicates": [776.3975155279503], "unit": "score", "name": "Earley", "value": 858.4043439999999}, {"lowerIsBetter": false, "replicates": [11764.70588235294], "unit": "score", "name": "Boyer", "value": 56.64935499999997}, {"lowerIsBetter": false, "replicates": [25974.358974358973], "unit": "score", "name": "RegExp", "value": 35.072472852912156}, {"lowerIsBetter": false, "replicates": [649.772579597141], "unit": "score", "name": "Splay", "value": 125.41464899999998}, {"lowerIsBetter": false, "replicates": [4835.748792270531], "unit": "score", "name": "NavierStokes", "value": 306.881118881119}], "name": "v8_7", "value": 20978.140170701958}]} 07:17:59 INFO - RETURN: dromaeo_css: 7039.60 07:17:59 INFO - RETURN: kraken: 1489.70 07:17:59 INFO - RETURN: v8_7: 20978.14 07:17:59 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,201,35]]", "result": "20978.14"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,201,35]]", "result": "1489.70"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,201,35]]", "result": "7039.60"}}} 07:17:59 INFO - Return code: 0 07:17:59 INFO - # TBPL SUCCESS # 07:17:59 INFO - Running post-action listener: _resource_record_post_action 07:17:59 INFO - Running post-run listener: _resource_record_post_run 07:18:01 INFO - Total resource usage - Wall time: 1225s; CPU: 13.0%; Read bytes: 4096; Write bytes: 507502592; Read time: 12; Write time: 619084 07:18:01 INFO - install - Wall time: 15s; CPU: 15.0%; Read bytes: 0; Write bytes: 234344448; Read time: 0; Write time: 423712 07:18:01 INFO - run-tests - Wall time: 1211s; CPU: 13.0%; Read bytes: 4096; Write bytes: 269365248; Read time: 12; Write time: 162856 07:18:01 INFO - Running post-run listener: _upload_blobber_files 07:18:01 INFO - Blob upload gear active. 07:18:01 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 07:18:01 INFO - Copying logs to upload dir... 07:18:01 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1254.706091 ========= master_lag: 0.47 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 55 secs) (at 2015-11-23 07:18:00.243751) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-23 07:18:00.247375) ========= 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=6ea65ccfe4e6b94e0d4f826f000001d8-1448290565.608392-1842730875 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/h7cJle0OS72hT2EgK2u93g/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.010047 build_url: 'https://queue.taskcluster.net/v1/task/h7cJle0OS72hT2EgK2u93g/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-23 07:18:00.300930) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 07:18:00.301462) ========= 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=6ea65ccfe4e6b94e0d4f826f000001d8-1448290565.608392-1842730875 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004634 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 07:18:00.351934) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-23 07:18:00.352298) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-23 07:18:00.352637) ========= ========= Total master_lag: 0.68 =========