builder: mozilla-beta_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-056 starttime: 1452203788.18 results: success (0) buildid: 20160107113526 builduid: fe6561f65d4f411099e1b7b63a1bc6ab revision: 97c3b29fb4f6 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-01-07 13:56:28.181494) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-01-07 13:56:28.181906) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-07 13:56:28.182199) ========= 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=52faae308a556c440401f8e5000001e8-1452203743.775068-309818213 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006322 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-07 13:56:28.204979) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-07 13:56:28.205271) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-07 13:56:28.218652) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-07 13:56:28.218904) ========= 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=52faae308a556c440401f8e5000001e8-1452203743.775068-309818213 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004651 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-07 13:56:28.267398) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-07 13:56:28.267664) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-07 13:56:28.268018) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-07 13:56:28.268288) ========= 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=52faae308a556c440401f8e5000001e8-1452203743.775068-309818213 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-01-07 13:56:29-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 223M=0s 2016-01-07 13:56:29 (223 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.159860 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-07 13:56:28.440501) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-07 13:56:28.440808) ========= 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=52faae308a556c440401f8e5000001e8-1452203743.775068-309818213 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019407 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-07 13:56:28.490775) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-01-07 13:56:28.491177) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 97c3b29fb4f6 --destination scripts --debug' in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 97c3b29fb4f6 --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=52faae308a556c440401f8e5000001e8-1452203743.775068-309818213 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-01-07 13:56:29,989 Setting DEBUG logging. 2016-01-07 13:56:29,989 attempt 1/10 2016-01-07 13:56:29,989 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/97c3b29fb4f6?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-01-07 13:56:30,898 unpacking tar archive at: mozilla-beta-97c3b29fb4f6/testing/mozharness/ program finished with exit code 0 elapsedTime=1.171505 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-01-07 13:56:29.676438) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-07 13:56:29.676739) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-07 13:56:29.684547) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-07 13:56:29.684796) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-07 13:56:29.685190) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 6 secs) (at 2016-01-07 13:56:29.685468) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 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', 'Mozilla-Beta', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Beta'] 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=52faae308a556c440401f8e5000001e8-1452203743.775068-309818213 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 13:56:31 INFO - MultiFileLogger online at 20160107 13:56:31 in /builds/slave/test-pgo 13:56:31 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 13:56:31 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 13:56:31 INFO - {'append_to_log': False, 13:56:31 INFO - 'base_work_dir': '/builds/slave/test-pgo', 13:56:31 INFO - 'blob_upload_branch': 'Mozilla-Beta', 13:56:31 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 13:56:31 INFO - 'branch': 'Mozilla-Beta', 13:56:31 INFO - 'buildbot_json_path': 'buildprops.json', 13:56:31 INFO - 'config_files': ('talos/linux_config.py',), 13:56:31 INFO - 'default_actions': ('clobber', 13:56:31 INFO - 'read-buildbot-config', 13:56:31 INFO - 'download-and-extract', 13:56:31 INFO - 'populate-webroot', 13:56:31 INFO - 'create-virtualenv', 13:56:31 INFO - 'install', 13:56:31 INFO - 'run-tests'), 13:56:31 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 13:56:31 INFO - 'download_minidump_stackwalk': True, 13:56:31 INFO - 'download_symbols': 'ondemand', 13:56:31 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 13:56:31 INFO - 'tooltool.py': '/tools/tooltool.py', 13:56:31 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 13:56:31 INFO - '/tools/misc-python/virtualenv.py')}, 13:56:31 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 13:56:31 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 13:56:31 INFO - 'installer_path': 'installer.exe', 13:56:31 INFO - 'log_level': 'info', 13:56:31 INFO - 'log_name': 'talos', 13:56:31 INFO - 'log_to_console': True, 13:56:31 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 13:56:31 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 13:56:31 INFO - 'opt_config_files': (), 13:56:31 INFO - 'pip_index': False, 13:56:31 INFO - 'sps_profile': False, 13:56:31 INFO - 'sps_profile_interval': 0, 13:56:31 INFO - 'suite': 'dromaeojs', 13:56:31 INFO - 'system_bits': '32', 13:56:31 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 13:56:31 INFO - 'title': 'talos-linux64-ix-056', 13:56:31 INFO - 'tooltool_cache': '/builds/tooltool_cache', 13:56:31 INFO - 'use_talos_json': True, 13:56:31 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 13:56:31 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 13:56:31 INFO - 'work_dir': 'build'} 13:56:31 INFO - ##### 13:56:31 INFO - ##### Running clobber step. 13:56:31 INFO - ##### 13:56:31 INFO - Running pre-action listener: _resource_record_pre_action 13:56:31 INFO - Running main action method: clobber 13:56:31 INFO - rmtree: /builds/slave/test-pgo/build 13:56:31 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 13:56:32 INFO - Running post-action listener: _resource_record_post_action 13:56:32 INFO - ##### 13:56:32 INFO - ##### Running read-buildbot-config step. 13:56:32 INFO - ##### 13:56:32 INFO - Running pre-action listener: _resource_record_pre_action 13:56:32 INFO - Running main action method: read_buildbot_config 13:56:32 INFO - Using buildbot properties: 13:56:32 INFO - { 13:56:32 INFO - "properties": { 13:56:32 INFO - "buildnumber": 69, 13:56:32 INFO - "product": "firefox", 13:56:32 INFO - "script_repo_revision": "production", 13:56:32 INFO - "builddir": "mozilla-beta_ubuntu64_hw_test-dromaeojs", 13:56:32 INFO - "repository": "", 13:56:32 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-beta pgo talos dromaeojs", 13:56:32 INFO - "buildid": "20160107113526", 13:56:32 INFO - "slavename": "talos-linux64-ix-056", 13:56:32 INFO - "pgo_build": "True", 13:56:32 INFO - "basedir": "/builds/slave/test-pgo", 13:56:32 INFO - "project": "", 13:56:32 INFO - "platform": "ubuntu64_hw", 13:56:32 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 13:56:32 INFO - "slavebuilddir": "test", 13:56:32 INFO - "scheduler": "tests-mozilla-beta-linux64-pgo-talos", 13:56:32 INFO - "branch": "mozilla-beta", 13:56:32 INFO - "repo_path": "releases/mozilla-beta", 13:56:32 INFO - "stage_platform": "linux64-pgo", 13:56:32 INFO - "builduid": "fe6561f65d4f411099e1b7b63a1bc6ab", 13:56:32 INFO - "revision": "97c3b29fb4f6" 13:56:32 INFO - }, 13:56:32 INFO - "sourcestamp": { 13:56:32 INFO - "repository": "", 13:56:32 INFO - "hasPatch": false, 13:56:32 INFO - "project": "", 13:56:32 INFO - "branch": "mozilla-beta-linux64-pgo-talos", 13:56:32 INFO - "changes": [ 13:56:32 INFO - { 13:56:32 INFO - "category": null, 13:56:32 INFO - "files": [ 13:56:32 INFO - { 13:56:32 INFO - "url": null, 13:56:32 INFO - "name": "http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1452195326/firefox-44.0.en-US.linux-x86_64.tar.bz2" 13:56:32 INFO - } 13:56:32 INFO - ], 13:56:32 INFO - "repository": "", 13:56:32 INFO - "rev": "97c3b29fb4f6", 13:56:32 INFO - "who": "sendchange", 13:56:32 INFO - "when": 1452203730, 13:56:32 INFO - "number": 7430888, 13:56:32 INFO - "comments": "Bug 1208525 - don_t fail to send LocationChange if the previous URI has no host r=margaret a=ritu", 13:56:32 INFO - "project": "", 13:56:32 INFO - "at": "Thu 07 Jan 2016 13:55:30", 13:56:32 INFO - "branch": "mozilla-beta-linux64-pgo-talos", 13:56:32 INFO - "revlink": "", 13:56:32 INFO - "properties": [ 13:56:32 INFO - [ 13:56:32 INFO - "buildid", 13:56:32 INFO - "20160107113526", 13:56:32 INFO - "Change" 13:56:32 INFO - ], 13:56:32 INFO - [ 13:56:32 INFO - "builduid", 13:56:32 INFO - "fe6561f65d4f411099e1b7b63a1bc6ab", 13:56:32 INFO - "Change" 13:56:32 INFO - ], 13:56:32 INFO - [ 13:56:32 INFO - "pgo_build", 13:56:32 INFO - "True", 13:56:32 INFO - "Change" 13:56:32 INFO - ] 13:56:32 INFO - ], 13:56:32 INFO - "revision": "97c3b29fb4f6" 13:56:32 INFO - } 13:56:32 INFO - ], 13:56:32 INFO - "revision": "97c3b29fb4f6" 13:56:32 INFO - } 13:56:32 INFO - } 13:56:32 INFO - Found installer url http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1452195326/firefox-44.0.en-US.linux-x86_64.tar.bz2. 13:56:32 INFO - Running post-action listener: _resource_record_post_action 13:56:32 INFO - ##### 13:56:32 INFO - ##### Running download-and-extract step. 13:56:32 INFO - ##### 13:56:32 INFO - Running pre-action listener: _resource_record_pre_action 13:56:32 INFO - Running main action method: download_and_extract 13:56:32 INFO - mkdir: /builds/slave/test-pgo/build/tests 13:56:32 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')]} 13:56:32 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1452195326/test_packages.json 13:56:32 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1452195326/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 13:56:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1452195326/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 13:56:32 INFO - Downloaded 1270 bytes. 13:56:32 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 13:56:32 INFO - Using the following test package requirements: 13:56:32 INFO - {u'common': [u'firefox-44.0.en-US.linux-x86_64.common.tests.zip'], 13:56:32 INFO - u'cppunittest': [u'firefox-44.0.en-US.linux-x86_64.common.tests.zip', 13:56:32 INFO - u'firefox-44.0.en-US.linux-x86_64.cppunittest.tests.zip'], 13:56:32 INFO - u'jittest': [u'firefox-44.0.en-US.linux-x86_64.common.tests.zip', 13:56:32 INFO - u'jsshell-linux-x86_64.zip'], 13:56:32 INFO - u'mochitest': [u'firefox-44.0.en-US.linux-x86_64.common.tests.zip', 13:56:32 INFO - u'firefox-44.0.en-US.linux-x86_64.mochitest.tests.zip'], 13:56:32 INFO - u'mozbase': [u'firefox-44.0.en-US.linux-x86_64.common.tests.zip'], 13:56:32 INFO - u'reftest': [u'firefox-44.0.en-US.linux-x86_64.common.tests.zip', 13:56:32 INFO - u'firefox-44.0.en-US.linux-x86_64.reftest.tests.zip'], 13:56:32 INFO - u'talos': [u'firefox-44.0.en-US.linux-x86_64.common.tests.zip', 13:56:32 INFO - u'firefox-44.0.en-US.linux-x86_64.talos.tests.zip'], 13:56:32 INFO - u'web-platform': [u'firefox-44.0.en-US.linux-x86_64.common.tests.zip', 13:56:32 INFO - u'firefox-44.0.en-US.linux-x86_64.web-platform.tests.zip'], 13:56:32 INFO - u'webapprt': [u'firefox-44.0.en-US.linux-x86_64.common.tests.zip'], 13:56:32 INFO - u'xpcshell': [u'firefox-44.0.en-US.linux-x86_64.common.tests.zip', 13:56:32 INFO - u'firefox-44.0.en-US.linux-x86_64.xpcshell.tests.zip']} 13:56:32 INFO - Downloading packages: [u'firefox-44.0.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 13:56:32 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')]} 13:56:32 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1452195326/firefox-44.0.en-US.linux-x86_64.common.tests.zip 13:56:32 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1452195326/firefox-44.0.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-44.0.en-US.linux-x86_64.common.tests.zip 13:56:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1452195326/firefox-44.0.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-44.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 13:56:35 INFO - Downloaded 22573298 bytes. 13:56:35 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-44.0.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test-pgo/build/tests 13:56:35 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-44.0.en-US.linux-x86_64.common.tests.zip 13:56:35 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-44.0.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 13:56:36 INFO - Return code: 0 13:56:36 INFO - Downloading packages: [u'firefox-44.0.en-US.linux-x86_64.common.tests.zip', u'firefox-44.0.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 13:56:36 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')]} 13:56:36 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1452195326/firefox-44.0.en-US.linux-x86_64.common.tests.zip 13:56:36 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1452195326/firefox-44.0.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-44.0.en-US.linux-x86_64.common.tests.zip 13:56:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1452195326/firefox-44.0.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-44.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 13:56:37 INFO - Downloaded 22573298 bytes. 13:56:37 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-44.0.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test-pgo/build/tests 13:56:37 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-44.0.en-US.linux-x86_64.common.tests.zip 13:56:37 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-44.0.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 13:56:38 INFO - Return code: 0 13:56:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:56:38 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1452195326/firefox-44.0.en-US.linux-x86_64.talos.tests.zip 13:56:38 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1452195326/firefox-44.0.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test-pgo/build/firefox-44.0.en-US.linux-x86_64.talos.tests.zip 13:56:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1452195326/firefox-44.0.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-44.0.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 13:56:41 INFO - Downloaded 11131970 bytes. 13:56:41 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-44.0.en-US.linux-x86_64.talos.tests.zip'] in /builds/slave/test-pgo/build/tests 13:56:41 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-44.0.en-US.linux-x86_64.talos.tests.zip 13:56:41 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-44.0.en-US.linux-x86_64.talos.tests.zip'] with output_timeout 1760 13:56:42 INFO - Return code: 0 13:56:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:56:42 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1452195326/firefox-44.0.en-US.linux-x86_64.tar.bz2 13:56:42 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1452195326/firefox-44.0.en-US.linux-x86_64.tar.bz2 to /builds/slave/test-pgo/build/firefox-44.0.en-US.linux-x86_64.tar.bz2 13:56:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1452195326/firefox-44.0.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test-pgo/build/firefox-44.0.en-US.linux-x86_64.tar.bz2'}, attempt #1 13:56:50 INFO - Downloaded 56630161 bytes. 13:56:50 INFO - Setting buildbot property build_url to http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1452195326/firefox-44.0.en-US.linux-x86_64.tar.bz2 13:56:50 INFO - mkdir: /builds/slave/test-pgo/properties 13:56:50 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 13:56:50 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 13:56:50 INFO - Contents: 13:56:50 INFO - build_url:http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1452195326/firefox-44.0.en-US.linux-x86_64.tar.bz2 13:56:50 INFO - Running post-action listener: _resource_record_post_action 13:56:50 INFO - Running post-action listener: set_extra_try_arguments 13:56:50 INFO - ##### 13:56:50 INFO - ##### Running populate-webroot step. 13:56:50 INFO - ##### 13:56:50 INFO - Running pre-action listener: _resource_record_pre_action 13:56:50 INFO - Running main action method: populate_webroot 13:56:51 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 13:56:51 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 13:56:51 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 13:56:51 INFO - '../fennec_ids.txt'], 13:56:51 INFO - 'tests': ['tcheck2']}, 13:56:51 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 13:56:51 INFO - '--tppagecycles', 13:56:51 INFO - '7'], 13:56:51 INFO - 'tests': ['tsvgm']}}, 13:56:51 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 13:56:51 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 13:56:51 INFO - 'tests': ['tresize', 'tcanvasmark']}, 13:56:51 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 13:56:51 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 13:56:51 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 13:56:51 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:56:51 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:56:51 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:56:51 INFO - 'talos_options': ['--e10s'], 13:56:51 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:56:51 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:56:51 INFO - 'tests': ['damp', 'tps']}, 13:56:51 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:56:51 INFO - 'talos_options': ['--e10s'], 13:56:51 INFO - 'tests': ['damp', 'tps']}, 13:56:51 INFO - 'g3': {'tests': ['dromaeo_dom']}, 13:56:51 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 13:56:51 INFO - 'other': {'tests': ['a11yr', 13:56:51 INFO - 'ts_paint', 13:56:51 INFO - 'tpaint', 13:56:51 INFO - 'sessionrestore', 13:56:51 INFO - 'sessionrestore_no_auto_restore']}, 13:56:51 INFO - 'other-e10s': {'talos_options': ['--e10s'], 13:56:51 INFO - 'tests': ['a11yr', 13:56:51 INFO - 'ts_paint', 13:56:51 INFO - 'tpaint', 13:56:51 INFO - 'sessionrestore', 13:56:51 INFO - 'sessionrestore_no_auto_restore']}, 13:56:51 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 13:56:51 INFO - 'tests': ['a11yr', 13:56:51 INFO - 'ts_paint', 13:56:51 INFO - 'tpaint', 13:56:51 INFO - 'sessionrestore', 13:56:51 INFO - 'sessionrestore_no_auto_restore']}, 13:56:51 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 13:56:51 INFO - 'tests': ['a11yr', 13:56:51 INFO - 'ts_paint', 13:56:51 INFO - 'tpaint', 13:56:51 INFO - 'sessionrestore', 13:56:51 INFO - 'sessionrestore_no_auto_restore']}, 13:56:51 INFO - 'other_l64': {'tests': ['a11yr', 13:56:51 INFO - 'ts_paint', 13:56:51 INFO - 'tpaint', 13:56:51 INFO - 'sessionrestore', 13:56:51 INFO - 'sessionrestore_no_auto_restore']}, 13:56:51 INFO - 'other_nol64': {'tests': ['a11yr', 13:56:51 INFO - 'ts_paint', 13:56:51 INFO - 'tpaint', 13:56:51 INFO - 'sessionrestore', 13:56:51 INFO - 'sessionrestore_no_auto_restore']}, 13:56:51 INFO - 'svgr': {'tests': ['tsvgx', 13:56:51 INFO - 'tsvgr_opacity', 13:56:51 INFO - 'tart', 13:56:51 INFO - 'tscrollx', 13:56:51 INFO - 'cart']}, 13:56:51 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 13:56:51 INFO - 'tests': ['tsvgx', 13:56:51 INFO - 'tsvgr_opacity', 13:56:51 INFO - 'tart', 13:56:51 INFO - 'tscrollx', 13:56:51 INFO - 'cart']}, 13:56:51 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:56:51 INFO - 'tests': ['tp5o']}, 13:56:51 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:56:51 INFO - 'talos_options': ['--e10s'], 13:56:51 INFO - 'tests': ['tp5o']}, 13:56:51 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:56:51 INFO - 'talos_options': ['--xperf_path', 13:56:51 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:56:51 INFO - 'tests': ['tp5n']}, 13:56:51 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:56:51 INFO - 'talos_options': ['--e10s', 13:56:51 INFO - '--xperf_path', 13:56:51 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:56:51 INFO - 'tests': ['tp5n']}}, 13:56:51 INFO - 'talos.zip': {'path': '', 13:56:51 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 13:56:51 INFO - Running post-action listener: _resource_record_post_action 13:56:51 INFO - ##### 13:56:51 INFO - ##### Running create-virtualenv step. 13:56:51 INFO - ##### 13:56:51 INFO - Running pre-action listener: _resource_record_pre_action 13:56:51 INFO - Running main action method: create_virtualenv 13:56:51 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 13:56:51 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 13:56:51 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 13:56:51 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 13:56:51 INFO - Using real prefix '/usr' 13:56:51 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 13:56:51 INFO - Installing distribute.............................................................................................................................................................................................done. 13:56:53 INFO - Installing pip.................done. 13:56:53 INFO - Return code: 0 13:56:53 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 13:56:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:56:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:56:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:56:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:56:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:56:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:56:53 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--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 0x7f4dda950f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfcc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1099600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1128350>, '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 0x1129250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11296e0>, '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': '52faae308a556c440401f8e5000001e8-1452203743.775068-309818213', '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 13:56:53 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 13:56:53 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 13:56:53 INFO - Using env: {'DISPLAY': ':0', 13:56:53 INFO - 'HOME': '/home/cltbld', 13:56:53 INFO - 'LANG': 'en_US.UTF-8', 13:56:53 INFO - 'LANGUAGE': 'en_US:en', 13:56:53 INFO - 'LOGNAME': 'cltbld', 13:56:53 INFO - 'MAIL': '/var/mail/cltbld', 13:56:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:56:53 INFO - 'MOZ_NO_REMOTE': '1', 13:56:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:56:53 INFO - 'NO_EM_RESTART': '1', 13:56:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:56:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 13:56:53 INFO - 'PWD': '/builds/slave/test-pgo', 13:56:53 INFO - 'SHELL': '/bin/bash', 13:56:53 INFO - 'SHLVL': '1', 13:56:53 INFO - 'TERM': 'linux', 13:56:53 INFO - 'TMOUT': '86400', 13:56:53 INFO - 'USER': 'cltbld', 13:56:53 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1452203743.775068-309818213', 13:56:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:56:53 INFO - '_': '/tools/buildbot/bin/python'} 13:56:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:56:53 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 13:56:53 INFO - Cleaning up... 13:56:53 INFO - Return code: 0 13:56:53 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 13:56:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:56:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:56:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:56:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:56:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:56:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:56:53 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--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 0x7f4dda950f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfcc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1099600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1128350>, '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 0x1129250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11296e0>, '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': '52faae308a556c440401f8e5000001e8-1452203743.775068-309818213', '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 13:56:53 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 13:56:53 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 13:56:53 INFO - Using env: {'DISPLAY': ':0', 13:56:53 INFO - 'HOME': '/home/cltbld', 13:56:53 INFO - 'LANG': 'en_US.UTF-8', 13:56:53 INFO - 'LANGUAGE': 'en_US:en', 13:56:53 INFO - 'LOGNAME': 'cltbld', 13:56:53 INFO - 'MAIL': '/var/mail/cltbld', 13:56:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:56:53 INFO - 'MOZ_NO_REMOTE': '1', 13:56:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:56:53 INFO - 'NO_EM_RESTART': '1', 13:56:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:56:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 13:56:53 INFO - 'PWD': '/builds/slave/test-pgo', 13:56:53 INFO - 'SHELL': '/bin/bash', 13:56:53 INFO - 'SHLVL': '1', 13:56:53 INFO - 'TERM': 'linux', 13:56:53 INFO - 'TMOUT': '86400', 13:56:53 INFO - 'USER': 'cltbld', 13:56:53 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1452203743.775068-309818213', 13:56:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:56:53 INFO - '_': '/tools/buildbot/bin/python'} 13:56:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:56:54 INFO - Downloading/unpacking psutil>=0.7.1 13:56:54 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 13:56:54 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 13:56:54 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 13:56:54 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 13:56:54 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 13:56:54 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 13:56:55 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 13:56:55 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 13:56:55 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 13:56:55 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:56:55 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:56:55 INFO - Installing collected packages: psutil 13:56:55 INFO - Running setup.py install for psutil 13:56:55 INFO - building 'psutil._psutil_linux' extension 13:56:55 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 13:56:56 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 13:56:56 INFO - building 'psutil._psutil_posix' extension 13:56:56 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 13:56:56 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 13:56:56 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:56:56 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:56:56 INFO - Successfully installed psutil 13:56:56 INFO - Cleaning up... 13:56:56 INFO - Return code: 0 13:56:56 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 13:56:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:56:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:56:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:56:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:56:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:56:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:56:56 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f4dda950f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfcc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1099600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1128350>, '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 0x1129250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11296e0>, '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': '52faae308a556c440401f8e5000001e8-1452203743.775068-309818213', '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 13:56:56 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test-pgo/build 13:56:56 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 13:56:56 INFO - Using env: {'DISPLAY': ':0', 13:56:56 INFO - 'HOME': '/home/cltbld', 13:56:56 INFO - 'LANG': 'en_US.UTF-8', 13:56:56 INFO - 'LANGUAGE': 'en_US:en', 13:56:56 INFO - 'LOGNAME': 'cltbld', 13:56:56 INFO - 'MAIL': '/var/mail/cltbld', 13:56:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:56:56 INFO - 'MOZ_NO_REMOTE': '1', 13:56:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:56:56 INFO - 'NO_EM_RESTART': '1', 13:56:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:56:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 13:56:56 INFO - 'PWD': '/builds/slave/test-pgo', 13:56:56 INFO - 'SHELL': '/bin/bash', 13:56:56 INFO - 'SHLVL': '1', 13:56:56 INFO - 'TERM': 'linux', 13:56:56 INFO - 'TMOUT': '86400', 13:56:56 INFO - 'USER': 'cltbld', 13:56:56 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1452203743.775068-309818213', 13:56:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:56:56 INFO - '_': '/tools/buildbot/bin/python'} 13:56:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:56:56 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 13:56:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:56:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:56:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:56:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:56:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:56:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:56:58 INFO - Downloading mozsystemmonitor-0.0.tar.gz 13:56:58 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 13:56:58 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 13:56:58 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 13:56:58 INFO - Installing collected packages: mozsystemmonitor 13:56:58 INFO - Running setup.py install for mozsystemmonitor 13:56:58 INFO - Successfully installed mozsystemmonitor 13:56:58 INFO - Cleaning up... 13:56:58 INFO - Return code: 0 13:56:58 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 13:56:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:56:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:56:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:56:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:56:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:56:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:56:58 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f4dda950f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfcc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1099600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1128350>, '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 0x1129250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11296e0>, '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': '52faae308a556c440401f8e5000001e8-1452203743.775068-309818213', '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 13:56:58 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test-pgo/build 13:56:58 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 13:56:58 INFO - Using env: {'DISPLAY': ':0', 13:56:58 INFO - 'HOME': '/home/cltbld', 13:56:58 INFO - 'LANG': 'en_US.UTF-8', 13:56:58 INFO - 'LANGUAGE': 'en_US:en', 13:56:58 INFO - 'LOGNAME': 'cltbld', 13:56:58 INFO - 'MAIL': '/var/mail/cltbld', 13:56:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:56:58 INFO - 'MOZ_NO_REMOTE': '1', 13:56:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:56:58 INFO - 'NO_EM_RESTART': '1', 13:56:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:56:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 13:56:58 INFO - 'PWD': '/builds/slave/test-pgo', 13:56:58 INFO - 'SHELL': '/bin/bash', 13:56:58 INFO - 'SHLVL': '1', 13:56:58 INFO - 'TERM': 'linux', 13:56:58 INFO - 'TMOUT': '86400', 13:56:58 INFO - 'USER': 'cltbld', 13:56:58 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1452203743.775068-309818213', 13:56:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:56:58 INFO - '_': '/tools/buildbot/bin/python'} 13:56:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:56:58 INFO - Downloading/unpacking blobuploader==1.2.4 13:56:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:56:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:56:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:56:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:56:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:56:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:57:00 INFO - Downloading blobuploader-1.2.4.tar.gz 13:57:00 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 13:57:00 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 13:57:00 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 13:57:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:57:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:57:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:57:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:57:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:57:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:57:00 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 13:57:00 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 13:57:00 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 13:57:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:57:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:57:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:57:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:57:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:57:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:57:01 INFO - Downloading docopt-0.6.1.tar.gz 13:57:01 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 13:57:01 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 13:57:01 INFO - Installing collected packages: blobuploader, requests, docopt 13:57:01 INFO - Running setup.py install for blobuploader 13:57:01 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 13:57:01 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 13:57:01 INFO - Running setup.py install for requests 13:57:01 INFO - Running setup.py install for docopt 13:57:01 INFO - Successfully installed blobuploader requests docopt 13:57:01 INFO - Cleaning up... 13:57:01 INFO - Return code: 0 13:57:01 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 13:57:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:57:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:57:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:57:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:57:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:57:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:57:01 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f4dda950f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfcc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1099600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1128350>, '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 0x1129250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11296e0>, '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': '52faae308a556c440401f8e5000001e8-1452203743.775068-309818213', '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 13:57:01 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/config 13:57:01 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --no-deps --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 13:57:01 INFO - Using env: {'DISPLAY': ':0', 13:57:01 INFO - 'HOME': '/home/cltbld', 13:57:01 INFO - 'LANG': 'en_US.UTF-8', 13:57:01 INFO - 'LANGUAGE': 'en_US:en', 13:57:01 INFO - 'LOGNAME': 'cltbld', 13:57:01 INFO - 'MAIL': '/var/mail/cltbld', 13:57:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:57:01 INFO - 'MOZ_NO_REMOTE': '1', 13:57:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:57:01 INFO - 'NO_EM_RESTART': '1', 13:57:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:57:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 13:57:01 INFO - 'PWD': '/builds/slave/test-pgo', 13:57:01 INFO - 'SHELL': '/bin/bash', 13:57:01 INFO - 'SHLVL': '1', 13:57:01 INFO - 'TERM': 'linux', 13:57:01 INFO - 'TMOUT': '86400', 13:57:01 INFO - 'USER': 'cltbld', 13:57:01 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1452203743.775068-309818213', 13:57:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:57:01 INFO - '_': '/tools/buildbot/bin/python'} 13:57:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:57:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 13:57:01 INFO - Running setup.py (path:/tmp/pip-PpGKbw-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 13:57:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 13:57:02 INFO - Running setup.py (path:/tmp/pip-sKZMmo-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 13:57:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 13:57:02 INFO - Running setup.py (path:/tmp/pip-swB00L-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 13:57:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 13:57:02 INFO - Running setup.py (path:/tmp/pip-ZY_D3y-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 13:57:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 13:57:02 INFO - Running setup.py (path:/tmp/pip-AJWrsa-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 13:57:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 13:57:02 INFO - Running setup.py (path:/tmp/pip-8mWkTy-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 13:57:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 13:57:02 INFO - Running setup.py (path:/tmp/pip-hEZGgC-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 13:57:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 13:57:02 INFO - Running setup.py (path:/tmp/pip-NTn7u6-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 13:57:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 13:57:02 INFO - Running setup.py (path:/tmp/pip-5E3g0a-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 13:57:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 13:57:02 INFO - Running setup.py (path:/tmp/pip-DARbeJ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 13:57:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 13:57:02 INFO - Running setup.py (path:/tmp/pip-xz61k4-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 13:57:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 13:57:02 INFO - Running setup.py (path:/tmp/pip-jhnH2b-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 13:57:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 13:57:02 INFO - Running setup.py (path:/tmp/pip-Tuv1kJ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 13:57:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 13:57:02 INFO - Running setup.py (path:/tmp/pip-aKmpCm-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 13:57:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 13:57:03 INFO - Running setup.py (path:/tmp/pip-T0Lg4T-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 13:57:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 13:57:03 INFO - Running setup.py (path:/tmp/pip-mz9Hi2-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 13:57:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 13:57:03 INFO - Running setup.py (path:/tmp/pip-USQHEZ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 13:57:03 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 13:57:03 INFO - Running setup.py install for manifestparser 13:57:03 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 13:57:03 INFO - Running setup.py install for mozcrash 13:57:03 INFO - Running setup.py install for mozdebug 13:57:03 INFO - Running setup.py install for mozdevice 13:57:03 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 13:57:03 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 13:57:03 INFO - Running setup.py install for mozfile 13:57:03 INFO - Running setup.py install for mozhttpd 13:57:03 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 13:57:03 INFO - Running setup.py install for mozinfo 13:57:03 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 13:57:03 INFO - Running setup.py install for mozInstall 13:57:04 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 13:57:04 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 13:57:04 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 13:57:04 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 13:57:04 INFO - Running setup.py install for mozleak 13:57:04 INFO - Running setup.py install for mozlog 13:57:04 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 13:57:04 INFO - Running setup.py install for moznetwork 13:57:04 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 13:57:04 INFO - Running setup.py install for mozprocess 13:57:04 INFO - Running setup.py install for mozprofile 13:57:04 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 13:57:04 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 13:57:04 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 13:57:04 INFO - Running setup.py install for mozrunner 13:57:04 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 13:57:04 INFO - Running setup.py install for mozscreenshot 13:57:04 INFO - Running setup.py install for moztest 13:57:04 INFO - Running setup.py install for mozversion 13:57:04 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 13:57:04 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 13:57:04 INFO - Cleaning up... 13:57:04 INFO - Return code: 0 13:57:04 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 13:57:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:57:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:57:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:57:05 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')]} 13:57:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:57:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:57:05 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 0x7f4dda950f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfcc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1099600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1128350>, '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 0x1129250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11296e0>, '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': '52faae308a556c440401f8e5000001e8-1452203743.775068-309818213', '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 13:57:05 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 13:57:05 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 13:57:05 INFO - Using env: {'DISPLAY': ':0', 13:57:05 INFO - 'HOME': '/home/cltbld', 13:57:05 INFO - 'LANG': 'en_US.UTF-8', 13:57:05 INFO - 'LANGUAGE': 'en_US:en', 13:57:05 INFO - 'LOGNAME': 'cltbld', 13:57:05 INFO - 'MAIL': '/var/mail/cltbld', 13:57:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:57:05 INFO - 'MOZ_NO_REMOTE': '1', 13:57:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:57:05 INFO - 'NO_EM_RESTART': '1', 13:57:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:57:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 13:57:05 INFO - 'PWD': '/builds/slave/test-pgo', 13:57:05 INFO - 'SHELL': '/bin/bash', 13:57:05 INFO - 'SHLVL': '1', 13:57:05 INFO - 'TERM': 'linux', 13:57:05 INFO - 'TMOUT': '86400', 13:57:05 INFO - 'USER': 'cltbld', 13:57:05 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1452203743.775068-309818213', 13:57:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:57:05 INFO - '_': '/tools/buildbot/bin/python'} 13:57:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:57:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 13:57:05 INFO - Running setup.py (path:/tmp/pip-Q844dY-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 13:57:05 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 1)) 13:57:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 13:57:05 INFO - Running setup.py (path:/tmp/pip-fWZGur-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 13:57:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.16 from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 13:57:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 13:57:05 INFO - Running setup.py (path:/tmp/pip-hkygFE-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 13:57:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 3)) 13:57:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 13:57:05 INFO - Running setup.py (path:/tmp/pip-YAzAPO-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 13:57:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.46 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)) 13:57:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 13:57:05 INFO - Running setup.py (path:/tmp/pip-5rFG7Q-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 13:57:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 5)) 13:57:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 13:57:05 INFO - Running setup.py (path:/tmp/pip-G520sJ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 13:57:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 6)) 13:57:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 13:57:05 INFO - Running setup.py (path:/tmp/pip-9zAfud-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 13:57:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.8 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)) 13:57:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 13:57:05 INFO - Running setup.py (path:/tmp/pip-YUtk3L-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 13:57:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 8)) 13:57:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 13:57:05 INFO - Running setup.py (path:/tmp/pip-LhbYZ1-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 13:57:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 9)) 13:57:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 13:57:05 INFO - Running setup.py (path:/tmp/pip-nD927V-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 13:57:05 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)) 13:57:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 13:57:05 INFO - Running setup.py (path:/tmp/pip-4yWOS6-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 13:57:06 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)) 13:57:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 13:57:06 INFO - Running setup.py (path:/tmp/pip-4PnODd-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 13:57:06 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)) 13:57:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 13:57:06 INFO - Running setup.py (path:/tmp/pip-GrcnXC-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 13:57:06 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)) 13:57:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 13:57:06 INFO - Running setup.py (path:/tmp/pip-Lov1TE-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 13:57:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 14)) 13:57:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 13:57:06 INFO - Running setup.py (path:/tmp/pip-C41ZkQ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 13:57:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 15)) 13:57:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 13:57:06 INFO - Running setup.py (path:/tmp/pip-7O97PG-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 13:57:06 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test-pgo/build/tests/mozbase/moztest in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 16)) 13:57:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 13:57:06 INFO - Running setup.py (path:/tmp/pip-gcWiwg-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 13:57:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 17)) 13:57:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 13:57:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 13:57:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 3)) 13:57:06 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.46->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 13:57:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.46->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 13:57:06 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.0->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 13:57:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:57:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:57:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:57:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:57:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:57:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:57:08 INFO - Downloading blessings-1.5.1.tar.gz 13:57:08 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 13:57:08 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 13:57:08 INFO - Installing collected packages: blessings 13:57:08 INFO - Running setup.py install for blessings 13:57:08 INFO - Successfully installed blessings 13:57:08 INFO - Cleaning up... 13:57:08 INFO - Return code: 0 13:57:08 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 13:57:08 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 13:57:08 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 13:57:08 INFO - Reading from file tmpfile_stdout 13:57:08 INFO - Current package versions: 13:57:08 INFO - argparse == 1.2.1 13:57:08 INFO - blessings == 1.5.1 13:57:08 INFO - blobuploader == 1.2.4 13:57:08 INFO - docopt == 0.6.1 13:57:08 INFO - manifestparser == 1.1 13:57:08 INFO - mozInstall == 1.12 13:57:08 INFO - mozcrash == 0.16 13:57:08 INFO - mozdebug == 0.1 13:57:08 INFO - mozdevice == 0.46 13:57:08 INFO - mozfile == 1.2 13:57:08 INFO - mozhttpd == 0.7 13:57:08 INFO - mozinfo == 0.8 13:57:08 INFO - mozleak == 0.1 13:57:08 INFO - mozlog == 3.0 13:57:08 INFO - moznetwork == 0.27 13:57:08 INFO - mozprocess == 0.22 13:57:08 INFO - mozprofile == 0.27 13:57:08 INFO - mozrunner == 6.11 13:57:08 INFO - mozscreenshot == 0.1 13:57:08 INFO - mozsystemmonitor == 0.0 13:57:08 INFO - moztest == 0.7 13:57:08 INFO - mozversion == 1.4 13:57:08 INFO - psutil == 3.1.1 13:57:08 INFO - requests == 1.2.3 13:57:08 INFO - wsgiref == 0.1.2 13:57:08 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 13: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')]} 13:57:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:57:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13: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')]} 13:57:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:57:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:57:08 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f4dda950f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfcc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1099600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1128350>, '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 0x1129250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11296e0>, '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': '52faae308a556c440401f8e5000001e8-1452203743.775068-309818213', '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 13:57:08 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/talos 13:57:08 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 -r /builds/slave/test-pgo/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 13:57:08 INFO - Using env: {'DISPLAY': ':0', 13:57:08 INFO - 'HOME': '/home/cltbld', 13:57:08 INFO - 'LANG': 'en_US.UTF-8', 13:57:08 INFO - 'LANGUAGE': 'en_US:en', 13:57:08 INFO - 'LOGNAME': 'cltbld', 13:57:08 INFO - 'MAIL': '/var/mail/cltbld', 13:57:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:57:08 INFO - 'MOZ_NO_REMOTE': '1', 13:57:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:57:08 INFO - 'NO_EM_RESTART': '1', 13:57:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:57:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 13:57:08 INFO - 'PWD': '/builds/slave/test-pgo', 13:57:08 INFO - 'SHELL': '/bin/bash', 13:57:08 INFO - 'SHLVL': '1', 13:57:08 INFO - 'TERM': 'linux', 13:57:08 INFO - 'TMOUT': '86400', 13:57:08 INFO - 'USER': 'cltbld', 13:57:08 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1452203743.775068-309818213', 13:57:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:57:08 INFO - '_': '/tools/buildbot/bin/python'} 13:57:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:57:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 13:57:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 2)) 13:57:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 3)) 13:57:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 4)) 13:57:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 5)) 13:57:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 6)) 13:57:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 7)) 13:57:08 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 8)) 13:57:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash>=0.15->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 13:57:08 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 3)) 13:57:08 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozlog>=3.0->mozcrash>=0.15->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 13:57:08 INFO - Cleaning up... 13:57:08 INFO - Return code: 0 13:57:08 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 13: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')]} 13:57:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:57:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13: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')]} 13:57:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:57:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:57:08 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f4dda950f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfcc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1099600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1128350>, '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 0x1129250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11296e0>, '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': '52faae308a556c440401f8e5000001e8-1452203743.775068-309818213', '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 13:57:08 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test-pgo/build 13:57:08 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 13:57:08 INFO - Using env: {'DISPLAY': ':0', 13:57:08 INFO - 'HOME': '/home/cltbld', 13:57:08 INFO - 'LANG': 'en_US.UTF-8', 13:57:08 INFO - 'LANGUAGE': 'en_US:en', 13:57:08 INFO - 'LOGNAME': 'cltbld', 13:57:08 INFO - 'MAIL': '/var/mail/cltbld', 13:57:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:57:08 INFO - 'MOZ_NO_REMOTE': '1', 13:57:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:57:08 INFO - 'NO_EM_RESTART': '1', 13:57:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:57:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 13:57:08 INFO - 'PWD': '/builds/slave/test-pgo', 13:57:08 INFO - 'SHELL': '/bin/bash', 13:57:08 INFO - 'SHLVL': '1', 13:57:08 INFO - 'TERM': 'linux', 13:57:08 INFO - 'TMOUT': '86400', 13:57:08 INFO - 'USER': 'cltbld', 13:57:08 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1452203743.775068-309818213', 13:57:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:57:08 INFO - '_': '/tools/buildbot/bin/python'} 13:57:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:57:09 INFO - Downloading/unpacking jsonschema 13:57:09 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 13:57:09 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 13:57:09 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 13:57:09 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 13:57:09 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 13:57:09 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 13:57:10 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 13:57:10 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fjsonschema-2.5.1-py2.py3-none-any.whl 13:57:10 INFO - Downloading/unpacking functools32 (from jsonschema) 13:57:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:57:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:57:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:57:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:57:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:57:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:57:10 INFO - Downloading functools32-3.2.3-2.tar.gz 13:57:11 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 13:57:11 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 13:57:11 INFO - warning: no files found matching '*.txt' 13:57:11 INFO - no previously-included directories found matching 'build' 13:57:11 INFO - no previously-included directories found matching 'dist' 13:57:11 INFO - no previously-included directories found matching '.git*' 13:57:11 INFO - Installing collected packages: jsonschema, functools32 13:57:11 INFO - Running setup.py install for functools32 13:57:11 INFO - warning: no files found matching '*.txt' 13:57:11 INFO - no previously-included directories found matching 'build' 13:57:11 INFO - no previously-included directories found matching 'dist' 13:57:11 INFO - no previously-included directories found matching '.git*' 13:57:11 INFO - Successfully installed jsonschema functools32 13:57:11 INFO - Cleaning up... 13:57:11 INFO - Return code: 0 13:57:11 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 13:57:11 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')]} 13:57:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:57:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:57:11 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')]} 13:57:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:57:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:57:11 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', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f4dda950f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfcc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1099600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1128350>, '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 0x1129250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11296e0>, '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': '52faae308a556c440401f8e5000001e8-1452203743.775068-309818213', '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 13:57:11 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', 'flake8'] in /builds/slave/test-pgo/build 13:57:11 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 flake8 13:57:11 INFO - Using env: {'DISPLAY': ':0', 13:57:11 INFO - 'HOME': '/home/cltbld', 13:57:11 INFO - 'LANG': 'en_US.UTF-8', 13:57:11 INFO - 'LANGUAGE': 'en_US:en', 13:57:11 INFO - 'LOGNAME': 'cltbld', 13:57:11 INFO - 'MAIL': '/var/mail/cltbld', 13:57:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:57:11 INFO - 'MOZ_NO_REMOTE': '1', 13:57:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:57:11 INFO - 'NO_EM_RESTART': '1', 13:57:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:57:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 13:57:11 INFO - 'PWD': '/builds/slave/test-pgo', 13:57:11 INFO - 'SHELL': '/bin/bash', 13:57:11 INFO - 'SHLVL': '1', 13:57:11 INFO - 'TERM': 'linux', 13:57:11 INFO - 'TMOUT': '86400', 13:57:11 INFO - 'USER': 'cltbld', 13:57:11 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1452203743.775068-309818213', 13:57:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:57:11 INFO - '_': '/tools/buildbot/bin/python'} 13:57:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:57:11 INFO - Downloading/unpacking flake8 13:57:11 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 13:57:11 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 13:57:11 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 13:57:11 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 13:57:11 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 13:57:11 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 13:57:13 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 13:57:13 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fflake8-2.5.0-py2.py3-none-any.whl 13:57:13 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 13:57:13 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 13:57:13 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 13:57:13 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 13:57:13 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 13:57:13 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 13:57:13 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 13:57:13 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 13:57:13 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmccabe-0.3.1-py2.py3-none-any.whl 13:57:13 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 13:57:13 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 13:57:13 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 13:57:13 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 13:57:13 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 13:57:13 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 13:57:13 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 13:57:13 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpyflakes-1.0.0-py2.py3-none-any.whl 13:57:13 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 13:57:13 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 13:57:13 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 13:57:13 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 13:57:13 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 13:57:13 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 13:57:13 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 13:57:13 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 13:57:13 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 13:57:13 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 13:57:13 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 13:57:13 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 13:57:13 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 13:57:13 INFO - no previously-included directories found matching 'docs/_build' 13:57:13 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 13:57:13 INFO - Running setup.py install for pep8 13:57:14 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 13:57:14 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 13:57:14 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 13:57:14 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 13:57:14 INFO - no previously-included directories found matching 'docs/_build' 13:57:14 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 13:57:14 INFO - Successfully installed flake8 mccabe pyflakes pep8 13:57:14 INFO - Cleaning up... 13:57:14 INFO - Return code: 0 13:57:14 INFO - Running post-action listener: _resource_record_post_action 13:57:14 INFO - Running post-action listener: _start_resource_monitoring 13:57:14 INFO - Starting resource monitoring. 13:57:14 INFO - ##### 13:57:14 INFO - ##### Running install step. 13:57:14 INFO - ##### 13:57:14 INFO - Running pre-action listener: _resource_record_pre_action 13:57:14 INFO - Running main action method: install 13:57:14 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 13:57:14 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 13:57:14 INFO - Reading from file tmpfile_stdout 13:57:14 INFO - Detecting whether we're running mozinstall >=1.0... 13:57:14 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 13:57:14 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 13:57:14 INFO - Reading from file tmpfile_stdout 13:57:14 INFO - Output received: 13:57:14 INFO - Usage: mozinstall [options] installer 13:57:14 INFO - Options: 13:57:14 INFO - -h, --help show this help message and exit 13:57:14 INFO - -d DEST, --destination=DEST 13:57:14 INFO - Directory to install application into. [default: 13:57:14 INFO - "/builds/slave/test-pgo"] 13:57:14 INFO - --app=APP Application being installed. [default: firefox] 13:57:14 INFO - mkdir: /builds/slave/test-pgo/build/application 13:57:14 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '/builds/slave/test-pgo/build/firefox-44.0.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test-pgo/build/application'] 13:57:14 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall /builds/slave/test-pgo/build/firefox-44.0.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test-pgo/build/application 13:57:29 INFO - Reading from file tmpfile_stdout 13:57:29 INFO - Output received: 13:57:29 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 13:57:29 INFO - Running post-action listener: _resource_record_post_action 13:57:29 INFO - ##### 13:57:29 INFO - ##### Running run-tests step. 13:57:29 INFO - ##### 13:57:29 INFO - Running pre-action listener: _resource_record_pre_action 13:57:29 INFO - Running main action method: run_tests 13:57:29 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 13:57:29 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 13:57:29 INFO - Python 2.7.3 13:57:29 INFO - Return code: 0 13:57:29 INFO - grabbing minidump binary from tooltool 13:57:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:57:29 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 0x1128350>, '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 0x1129250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11296e0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 13:57:29 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 13:57:29 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 13:57:29 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 13:57:29 INFO - Return code: 0 13:57:29 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 13:57:29 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 13:57:29 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 13:57:29 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 13:57:29 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 13:57:29 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 13:57:29 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 13:57:30 INFO - Return code: 0 13:57:30 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1452195326/firefox-44.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-056', '--webServer', 'localhost'] in /builds/slave/test-pgo/build 13:57:30 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --debug --branchName Mozilla-Beta --suite dromaeojs --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1452195326/firefox-44.0.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-056 --webServer localhost 13:57:30 INFO - Using env: {'DISPLAY': ':0', 13:57:30 INFO - 'HOME': '/home/cltbld', 13:57:30 INFO - 'LANG': 'en_US.UTF-8', 13:57:30 INFO - 'LANGUAGE': 'en_US:en', 13:57:30 INFO - 'LOGNAME': 'cltbld', 13:57:30 INFO - 'MAIL': '/var/mail/cltbld', 13:57:30 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 13:57:30 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 13:57:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:57:30 INFO - 'MOZ_NO_REMOTE': '1', 13:57:30 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 13:57:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:57:30 INFO - 'NO_EM_RESTART': '1', 13:57:30 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:57:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 13:57:30 INFO - 'PWD': '/builds/slave/test-pgo', 13:57:30 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 13:57:30 INFO - 'SHELL': '/bin/bash', 13:57:30 INFO - 'SHLVL': '1', 13:57:30 INFO - 'TERM': 'linux', 13:57:30 INFO - 'TMOUT': '86400', 13:57:30 INFO - 'USER': 'cltbld', 13:57:30 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1452203743.775068-309818213', 13:57:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:57:30 INFO - '_': '/tools/buildbot/bin/python'} 13:57:30 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1452195326/firefox-44.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-056', '--webServer', 'localhost'] with output_timeout 3600 13:57:30 INFO - mozversion INFO | application_buildid: 20160107113526 13:57:30 INFO - mozversion INFO | application_changeset: 97c3b29fb4f6cd97e9e0b3f5b35e4e95f1125394 13:57:30 INFO - mozversion INFO | application_display_name: Nightly 13:57:30 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 13:57:30 INFO - mozversion INFO | application_name: Firefox 13:57:30 INFO - mozversion INFO | application_remotingname: firefox 13:57:30 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/releases/mozilla-beta 13:57:30 INFO - mozversion INFO | application_vendor: Mozilla 13:57:30 INFO - mozversion INFO | application_version: 44.0 13:57:30 INFO - mozversion INFO | platform_buildid: 20160107113526 13:57:30 INFO - mozversion INFO | platform_changeset: 97c3b29fb4f6cd97e9e0b3f5b35e4e95f1125394 13:57:30 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/releases/mozilla-beta 13:57:30 INFO - mozversion INFO | platform_version: 44.0 13:57:30 INFO - 2016-01-07 13:57:30,364 DEBUG : using testdate: 1452203850 13:57:30 INFO - 2016-01-07 13:57:30,364 DEBUG : actual date: 1452203850 13:57:30 INFO - 2016-01-07 13:57:30,416 INFO : starting webserver on 'localhost:52532' 13:57:30 INFO - 2016-01-07 13:57:30,417 INFO : Starting test suite talos-linux64-ix-056 13:57:30 INFO - 2016-01-07 13:57:30,417 INFO : Starting test dromaeo_css 13:57:30 INFO - 2016-01-07 13:57:30,418 DEBUG : operating with platform_type : linux_ 13:57:30 INFO - 2016-01-07 13:57:30,418 INFO : Initialising browser for dromaeo_css test... 13:57:30 INFO - 2016-01-07 13:57:30,434 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpe8Jx2a/profile http://localhost:52532/getInfo.html 13:57:34 INFO - 2016-01-07 13:57:34,199 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 13:57:34 INFO - 2016-01-07 13:57:34,199 DEBUG : BROWSER_OUTPUT: colorDepth:24 13:57:34 INFO - 2016-01-07 13:57:34,199 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 13:57:34 INFO - 2016-01-07 13:57:34,199 DEBUG : BROWSER_OUTPUT: __metrics 13:57:34 INFO - 2016-01-07 13:57:34,301 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 13:57:35 INFO - 2016-01-07 13:57:35,665 INFO : Browser initialized. 13:57:35 INFO - 2016-01-07 13:57:35,666 INFO : Running cycle 1/1 for dromaeo_css test... 13:57:35 INFO - 2016-01-07 13:57:35,666 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpe8Jx2a/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 13:57:47 INFO - 2016-01-07 13:57:47,269 DEBUG : BROWSER_OUTPUT: RSS: Main: 128851968 13:57:47 INFO - 2016-01-07 13:57:47,269 DEBUG : BROWSER_OUTPUT: 13:58:38 INFO - 2016-01-07 13:58:38,322 DEBUG : BROWSER_OUTPUT: 1452203918321 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] 14:00:46 INFO - 2016-01-07 14:00:46,512 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52532/tests/dromaeo/cssquery-dojo.html (next: http://localhost:52532/tests/dromaeo/cssquery-ext.html) 14:00:47 INFO - 2016-01-07 14:00:47,497 DEBUG : BROWSER_OUTPUT: RSS: Main: 220475392 14:00:47 INFO - 2016-01-07 14:00:47,497 DEBUG : BROWSER_OUTPUT: 14:03:49 INFO - 2016-01-07 14:03:49,503 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52532/tests/dromaeo/cssquery-ext.html (next: http://localhost:52532/tests/dromaeo/cssquery-jquery.html) 14:03:50 INFO - 2016-01-07 14:03:50,065 DEBUG : BROWSER_OUTPUT: RSS: Main: 209530880 14:03:50 INFO - 2016-01-07 14:03:50,065 DEBUG : BROWSER_OUTPUT: 14:06:51 INFO - 2016-01-07 14:06:51,799 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52532/tests/dromaeo/cssquery-jquery.html (next: http://localhost:52532/tests/dromaeo/cssquery-mootools.html) 14:06:52 INFO - 2016-01-07 14:06:52,360 DEBUG : BROWSER_OUTPUT: RSS: Main: 205463552 14:06:52 INFO - 2016-01-07 14:06:52,361 DEBUG : BROWSER_OUTPUT: 14:09:54 INFO - 2016-01-07 14:09:54,089 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52532/tests/dromaeo/cssquery-mootools.html (next: http://localhost:52532/tests/dromaeo/cssquery-prototype.html) 14:09:54 INFO - 2016-01-07 14:09:54,652 DEBUG : BROWSER_OUTPUT: RSS: Main: 190951424 14:09:54 INFO - 2016-01-07 14:09:54,652 DEBUG : BROWSER_OUTPUT: 14:12:57 INFO - 2016-01-07 14:12:57,028 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52532/tests/dromaeo/cssquery-prototype.html (next: http://localhost:52532/tests/dromaeo/cssquery-yui.html) 14:12:57 INFO - 2016-01-07 14:12:57,590 DEBUG : BROWSER_OUTPUT: RSS: Main: 193294336 14:12:57 INFO - 2016-01-07 14:12:57,590 DEBUG : BROWSER_OUTPUT: 14:15:59 INFO - 2016-01-07 14:15:59,457 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52532/tests/dromaeo/cssquery-yui.html (next: http://localhost:52532/tests/dromaeo/cssquery-dojo.html) 14:15:59 INFO - 2016-01-07 14:15:59,700 DEBUG : BROWSER_OUTPUT: RSS: Main: 233299968 14:15:59 INFO - 2016-01-07 14:15:59,701 DEBUG : BROWSER_OUTPUT: 14:15:59 INFO - 2016-01-07 14:15:59,701 DEBUG : BROWSER_OUTPUT: __start_tp_report 14:15:59 INFO - 2016-01-07 14:15:59,701 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 14:15:59 INFO - 2016-01-07 14:15:59,701 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 14:15:59 INFO - 2016-01-07 14:15:59,701 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 14:15:59 INFO - 2016-01-07 14:15:59,704 DEBUG : BROWSER_OUTPUT: |0;dojo.html;3289.7532685048623;3432.1591210153483;3462.948055779162;3467.185211475303;3492.8428220730066;5611.887762244753;5640.125780504023;5643.8024669136585;5672.035753921833;5685.914711279329;5635.351934527531;5681.431856814327;5684.090545512719;5694.971525142379;5714.942850571493;5009.699418034911;5150.716710580917;5166.276721259027;5252.264682944372;5326.7869285228735;5215.947840521584;5224.477552244764;5224.63427560071;5231.947680523184;5242.056429842627;5123.052235336456;5148.974255128738;5234.607404444663;5272.446393128724;5297.814576489824;5341.679499230039;5395.78416863325;5396.811111611114;5402.405735369106;5406.270153529283;5032.144535428949;5282.683039017671;5292.788288468457;5320.095583750772;5341.813036543703;5438.646487978269;5447.45525447456;5526;5533.253010843525;5554.638948468337;6184.87630247397;6190.876182476371;6235.438810507076;6243.313235544087;6254.499640028832;6031.577789554733;6092.189959943392;6257.374262573751;6280.560360774748;6288.402601752872;5663.433656634304;5744.454276843693;5752.2234498342605;5752.568557358215;5779.826605201851;6263.060540918898;6279.780207692709;6281.842953926189;6282.183316168869;6284.622922624657;5927.436893495111;5995.730192141364;6025.216721826222;6099.340948376802;6111.755529778848;6139.785107521305;6143.508519318444;6265.091561723524;6269.185005949289;6272.435480806749;6206.875862482725;6218.751249949952;6221.688915554295;6222.284437289679;6234.812955611339;5968.253968253968;6053.243344581927;6069.908951365733;6178.073289006595;6197.287311959182;4698.624110071186;4710.8351207707565;4711;4731.503192164773;4735.668503204812;4176.415301857743;4181;4189.6229339359;4193.937090943638;4200.957990420118;5724.828255152269;5734.856628584319;5812.564057695605;5821.417858214145;5836.912446313224;6130.754769809158;6190.442860142609;6198.039303907812;6198.535109866778;6202.100695399232;5835.124731290341;5844.561657875592;5847.853803654858;5851.268591426072;5876;5221.477852214824;5275.868103297448;5306.336707911511;5392.191171324333;5414;6340.7463701451425;6342.397472240037;6343.873122537616;6346.079818426302;6348.746050157942;6037.78867739627;6170.6914654268;6176.073588961512;6178.1659475971965;6185.84535386601;6127.693615319127;6201.441870231701;6319.842003949938;6332.556721029484;6343.841403964938;6044.304904935989;6160.014397696347;6169.167162433014;6172.753089876534;6190.442860142609;6014.218151640259;6114.597693712768;6171.907421388593;6204.81385558434;6205.317415084247;5883.352831188651;5940.495057920125;5947.762089516371;5950.285965684146;5969.3732158122775;5973.462388384893;6026.096085587197;6049.51603871698;6070.0591408331775;6072.544559157993;5823.534117270524;5826.446487583673;5936.732847021808;5960.0761881908375;5990.34106248321;6022.759089636365;6128.295246046761;6130.754769809158;6133.60131591463;6134.2332208473945;5983.222181116601;5997.430244126801;6000.249968753906;6002.129691194839;6021.849453763691 14:15:59 INFO - 2016-01-07 14:15:59,705 DEBUG : BROWSER_OUTPUT: |1;ext.html;566.3515275010113;599.0654578856982;601.2184160591233;605.4157737783039;624.5752888036134;35828.64171358286;44900.55099449005;45652.315215271796;45746.31380529295;45796.771016144914;47598.76200618992;48187.759061204735;48219.758901205445;48229.7588512057;48277;8237.876431853527;8377.162283771635;8910.732678019669;9212.170904618582;10532.47337633119;10775.622853200139;10930.398828064453;10938.617148399808;10940.835887461695;10944.960228778253;10905.400202988832;11019.953104455064;11023.283486573348;11031.779364412707;11039.944800275987;10781.299215550964;10816.296940698829;10860.13118950482;10862.891371086267;10885;10659.093977011964;10838.837417438745;10840.186985976005;10847.67456976292;10868.402237876913;46366;46876;47006.29490557644;47018.294725579144;47045.529544704455;3578.3022310649435;3615.7288203384587;3659.3413185626578;3801.258754542865;4162.646175075122;33321.3335733284;33370.666293336995;33376;33435.16412089693;33456.16359591005;3978.4430179774854;4010.6590939770153;4060.1879624075304;4090.754554726726;4118.320477121271;316766;316900;317730;317818;319632;66864.6656766713;68427;70769;75233;77549.61225193838;70811.29188708047;70839;70864.64567677128;70926;71187.64406177936;18074.457766267034;18111;18223.271069157352;18241.087945602932;18262.63474730498;12607.810882836764;12626.747465050648;12642;12652.746945061232;12717.427715752814;23130.19044333474;23428.18001369944;23442.17952371659;23479;23521;8605.096464871098;8704.390692651581;8710.085441028728;8778.60496277669;8797.736067917973;892.7009451833709;956.5791051937265;987.7678745494803;997.9451130187764;1093.5953697132113;28426.715732842407;34561.827190863885;35120.82439587837;35209.82395088008;35353.64646353555;1086.2939089591828;1117.3072694929197;1122.1247427006947;1123.9100871930225;1162.604714397109;14109.435622574982;15991.28039238237;16107.919460402623;16198.271077801528;18209.271629134688;465798;471509;472679;473045;475048;63239;63298.68350658217;63591;63869.36130638727;63908;1346.8451128120196;1407.8592140786045;1447.7683570628649;1481.1853480585635;1487.0408586461672;31932;31942.361152777277;32046;32397.676023239466;32690;52535.47464525306;52710;53150;53232.467675322754;53335.199971999675;327823;329444;329677;329771;330983;36894.44658330181;37198.81400593088;37285.25429491449;37583.43624845684;37750.979921606755;48672.269915952;48989.755051224514;49534;50111.498885012144;50162;39229.60770392259;39518.40722389224;39758.403623946244;40264.59735402725;41104.794476027426;40530.594694052685;41489.170216594895;41636;42349.57650423457;42549;41149.588504115774;41357.37963930483;41393.79303103465;43499.56500434955;44186;35696.464553031205;37149.814250928575;37290.45603761432;37857.24285514219;38096.23807523779;26414.735852641996;26798.19605411841;26854.78836309152;26946.46107077808;27105.86447067752 14:15:59 INFO - 2016-01-07 14:15:59,708 DEBUG : BROWSER_OUTPUT: |2;jquery.html;373.1194381260227;374.0368550981221;381.44690199211135;381.608850927799;385.2429975098931;15105.169215693133;16573.50279491614;17281.222344994472;19630.607387852233;19651.410457686292;13712.314384280797;14045;14084.225367604779;19808.40574782759;20073;4930.580900623451;5050.191969284915;5050.974745126269;5051.3180720602795;5055.014272216919;3917.1969746202103;3947.5657677655436;5006.173981293082;5267.315249017623;5424.1321388577835;5321.775991521952;5341.866453338659;5351.973240133794;5356.785728570852;5369.838904832861;5226.477352264781;5335.626506144571;5355.892882142335;5356.678599284036;5359.490848369399;4661.580457758818;4675.275332323496;4676.392069031038;4679;4679.438467383901;14560.271986400743;14950.700985980327;15375.154366509838;15481.225938703132;15501.612459688598;2129.1376992317983;2147.133919639255;2215.5125872308067;2252.7972482476657;2274.9090036398525;10684.893151068467;10828.187885908588;10938.726531836688;11014.834777478345;11044.392558409285;1808.3941879470394;1908.809119088094;1920.1455352368203;1927.759030121235;1932.3816378758802;67087.3291267086;68162.31837681659;69079.30920690778;69142;70168.64915675389;7886.132525422199;7903.841923161504;7934.325582325567;7962.800929976681;8006.439549231614;9677.564509597085;9758.512074396394;9762.951185244028;9769.658061967939;9777.902220977841;6308.495320374359;6368.363163683687;6383.585066970632;6410.775622853178;6439.839004024937;6576.145101136822;6582.407583317525;6583.177102862142;6629.3370662934285;6666.033425153326;3683.134463401152;3709.8330575124182;3719.0702324418894;3741.3639681254253;3741.85032598693;1267.6070418170398;1270.5680068776476;1292.9353532323346;1293.3468598357956;1327.4159369877223;534.9732513374315;535.8767483478822;541.8401571536327;553.8670719027485;584.7690162385834;11682.649520514398;12764.872351276554;12921.870781292255;13432.261225632488;13458;560.0674876330863;568.0626965506947;577.5956830218863;580.8896309701144;583.4894467341077;7142.964285178541;7223.735846226889;7481.438892083115;7499.287567681062;7608.619569021526;592442;609216;610839;634033;638993;82965;84635;84682;87191;87384;603.9003564411911;614.9692515374303;620.0606081786008;621.0249907645044;621.0466933257518;11883.821742673694;12261.034981151033;12467.127301088836;12475.126741128033;12732.490700371882;38389;38591;39224.60775392209;39250.80374598223;39274.214515708954;48805.755971219914;49249.507504925925;53744;53985;55958;7591.962040189764;7682.540317339687;7683.615819209129;7722.729704460542;7767.72812951544;11434.142439316918;11754.177207595729;13148.539801106916;13476.93261533686;13569.389377478235;11172.720681983015;11813.704657383634;11851.407429628312;11852;11908.04735621131;11195.72010699739;11312.6040588579;11335.206535542433;11369.488373023069;11609.30344179352;11792.23350482216;11905.226160299553;11910.464029118884;11945.820812687643;12237.0822188338;7701.152873184057;7798.415118865994;7815.374770018499;7860;7909.762707118795;12104.152709310263;12192.268463892195;12229.93885030569;12242.877571224173;12429 14:15:59 INFO - 2016-01-07 14:15:59,710 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1563.7498000319952;1568.451042135252;1826.2603645523568;1890.5084677983725;1890.9716354254683;7600.315971562558;7716.228377162295;8291.792705182366;8468.830623387536;8471.534065626396;7905.565193914347;8041.195880411956;8097.392695547828;8136.837263254732;8176.877346839802;2436.6832311799485;2491.3397949543387;2491.825572209946;2494.8128890333205;2495.214007587613;2130.456733532947;2163.6105501009893;2465.6055031195015;2474.7277799442136;2544;2469.061756532524;2495.0643508684243;2506.4736405354897;2541.3265484646586;2542.7965762738936;2394.7126344838557;2399.712034555847;2427.4174198192395;2427.417419819248;2430.222328854767;2472.505498900227;2497.675302210719;2499.4126380300613;2500.362407586072;2501.187114187896;8416.789580260482;8510.957445212796;8515.361347898932;8519;8525.914740852573;5162.380514338303;5203.895922081575;5216.165413533817;5216.426193118754;5250.44870288618;3329.6337402885665;3418.572678415198;3438.6905178534053;3441.9655803441897;3468.4277094279414;1173.4719376280707;1194.814803705427;1197.239752756997;1221.126894270592;1230.9721382645503;11680.0655947524;11798.764024719543;11826.822597660956;11828.639706433783;11833;4806.423229212517;4825.227963525889;4854.660173787801;4925.433575138905;4937.728424936591;9355.859662105075;9376.718698439057;9397.483138427315;9427.387219830689;9436.480993545283;5112.028714544224;5117.488251174853;5123.897522049539;5127.1540195867265;5130.563902068291;4737.360456338351;4740.7392593407;4747.86051347674;4750.548697873696;4751.239801631722;3311.519829624739;3785.7733787111197;3790.298794722985;3809.142942837839;3821.7133714971487;1090.547422819537;1149.6953307373553;1163.2497039409534;1175.670812172593;1194.7491026884452;1119.7088756923097;1160.8200728887036;1167.8773728758529;1449.8840092792552;1515.1515151514966;7999.36005119589;8035.357171426272;8038.437309388287;8058.717944871902;8068.919310806817;786.2648423723837;794.412135020081;796.4584082823735;797.9361651067901;909.7816524034184;6312.558120931582;6351.926199703165;6415.518836087312;6428.260750013808;6438;10116.747081323027;10339.689809305733;10360.896391036144;10382.221333399873;10416.5833366666;10095.697129086138;10300.948495257475;10325.74185645365;10331.586736530606;10351.378917264989;7959.801004974922;8024.398170137263;8026.638801254075;8035.477693949874;8040.919590804017;7657.617119143909;7666.769996900102;7698.34564062061;7733.651985660546;7849.5682737447705;9153.771155720893;9274.397164184307;9342.813143737223;9347.953260233928;9369.765755855886;9338.252939764938;9485.478298693639;9508.144267016001;9591.088846559565;9614.9038509614;7018.6490675465;7069.71721131149;7085;7088.362047415551;7089.113860767404;7479.738209162653;7637.198094200029;7984.481008734414;8145.71489997871;8164.346852251924;7483.438742094474;7621.3902887769955;7666.38668906475;7714.961425192838;7814.179511151247;7506.774796756106;7552.962235188789;7621.961890190513;7687.846243075219;7695.615219239127;7636.656350464354;7657.272559106876;7697.076350837935;7811.648475818715;7829.217078292125;6839.897401538881;6884.345987131214;6898.448124149955;6899.344562266577;6899.517033807585;7076.2923707628825;7132.8216794578475;7138.14342278909;7164.67758950838;7191.460640452092 14:15:59 INFO - 2016-01-07 14:15:59,711 DEBUG : BROWSER_OUTPUT: |4;prototype.html;358.0047468038852;360.65737549328145;361.45420415173083;363.6781448418149;363.7890023786204;5710.400407957157;5834.241548598677;5843.970780146099;5875.32433770116;5883.6763977981245;5685.658860468375;5787.855303617412;5789.189513468107;5816.389279125694;5818;4580;4596.977015114937;4614.584687378136;4615.376924115235;4622.8150873965005;4428.689991700582;4501.077279157781;4513.706609070417;4609.746463944499;4614.215583350839;4558.384618076567;4561.635069194456;4574.016586433916;4592.839250626229;4593.885152871171;4527.343535187412;4538.546145385468;4553.203189441851;4560.817567297304;4564.018735971748;4046.615571520701;4050.3721923101966;4057.431959525669;4060.3909413587903;4060.959390406117;5562.221289019541;5645.125005624135;5647.265855438808;5660.943390566083;5663.915041274384;5296.523312901819;5298.072837253465;5313.335833020872;5313.867153321159;5318.388385335697;5942.97028514859;6258.968705156445;6261.937380626181;6264.060390941395;6273.247210334744;4325.610695037431;4387.42963414754;4421.712588681726;4427.225235583792;4435.401220835211;6296.370362963713;6359.55483116182;6394.840128996766;6409.4551963083195;6419;4540.205464043779;4545.38637283969;4565.840195593205;4568.634509239253;4574.519675434098;4565.315202719618;4627.375304333872;4637.1653102441205;4647.721136731807;4686.835960741358;5299.8410047698635;5304.92042619361;5309.946900531023;5311.575073994071;5312.946870531246;6237.002079667232;6237.220347456568;6239.220097487814;6244.37556244381;6256.43692067707;1656.403694669918;1675.9078250696084;1680.857127144182;1681.6048228666255;1682.4616122840819;1127.3799410324289;1130;1131.6548452722;1138.317009794117;1164.7030007348071;6044.395560443921;6059.21230240066;6062.302835174011;6064.575479716465;6072.908906366408;6310.936890631035;6365.204349456318;6369.904451433232;6376.936230637727;6389.488840892717;5944.554158438134;5996.580239383288;6054.939450605526;6057.757689692451;6063.514918806485;3515.7870534666013;3537;3537.4340105582983;3540.061883600848;3542.574891013095;6480.675966201671;6482.286948435668;6487.805365839033;6491.642959637265;6492.318306577836;6498.805035848932;6504.707288172043;6508.9349106508325;6510.934890651128;6517.9348206517325;6441.613503189824;6654.301298363699;6663.200415950117;6675.933240667531;6677.09859169006;6266.37336266388;6347.3652634738;6481.157449531531;6482.448991835747;6494.512911531559;6271.090691849748;6339.017452294902;6364.6181229126405;6374.617522948638;6375.203099612549;6583.111279977142;6603;6606.405423511907;6618.172728408949;6621.50338724588;4525.981654127795;4566;4568.223402021731;4573.176828170961;4573.519780423007;6366.458850997532;6376.808695739135;6380.744770209325;6386.552941294251;6388.329225431263;6274.184356033869;6274.435300822948;6277.3408792078;6277.686115694289;6285.591436556792;6213.471854892204;6263.248410190807;6263.279722831932;6269.811905642838;6270.404311590391;6194.783182588588;6201.193844800147;6206.565540412308;6207.255129384503;6208.658523781055;6265.96867015662;6289.779857704958;6301.180846489927;6308.400701933309;6328;6096.146539484387;6112.32764395925;6174.598651087665;6177.2587289525545;6183.690815459299 14:15:59 INFO - 2016-01-07 14:15:59,714 DEBUG : BROWSER_OUTPUT: |5;yui.html;833.6582001379436;870.5690683111859;889.6041261638566;938.1322276893872;957.9521023948801;15041.699166016673;15533.301001454933;15536.145511996836;15559.611009724735;15567.532974010785;14195.858041419582;14286.785698214535;14375.928120359384;14376.928115359435;14385.280735963186;905.7871400220943;913.2465715784471;920.3787443475661;921.1709461484684;922.6447817590242;895.852184389575;903.1645727701882;904.8823652925144;905.7780843693305;906.8730377747121;952.3952290295642;960.0399600399601;961.8941916389226;962.0331566775416;962.4081190068127;954.1603389017689;954.346272803132;955.1833182628822;955.5317894231777;956.3974695941547;703.8275622472527;705.5061456980135;705.7424040225333;705.8941158826166;706.3113464372248;14091.154530728087;14145.434182632682;14179.503717369842;14243.715125697532;14266.429342826275;11339.943300283447;11598.71003224926;11661.300321980709;12015.879841201564;12029.338386388745;10063.798724025479;10459.320144190604;10631.362118272928;10631.468426578718;10705.518251678694;3722.5532936047575;3726.81365931705;3758.774473531597;3803.315403227418;3812.390017597171;44976.77511612454;46307.768461157815;50092.24861627115;50192.74903625495;51757.7412112937;10518.368897866152;10752.301100428447;10864.130869530418;10908.672739817817;11132.666020019413;13259.270740109387;13415.865841341656;21044.894775526023;21053.57892842165;21061.789382105984;7349.55902645843;7406.370458510979;7526.849463010709;7557.2820582044615;7648.655810488542;4446.133004064176;4876.926846097312;4892.926606100911;4965.106280869406;4976.5023497649945;3063.525153601151;3067.76991725617;3077.9076627700756;3082.722554970019;3087.212760745995;488.9828855990023;493.26996045852337;501.79175642108845;502.51507295460056;506.501096420026;711.7864640607797;724.5401860682952;752.1913942511821;755.8948328903977;760.068915578412;8718.215360617574;8778.34162437807;8834.337424693045;8879.866801997976;8897.288216942628;588.9823305300848;658.0819756439739;742.6101296819105;750.572173860905;757.1293013034943;4039.151778126626;4048.959510404917;4123.628873401408;4157.605027522381;4195.349720793282;65746.67126664336;68270.65864670645;69372.653136735;69613;69890.65054674796;46620;54202.45797541974;57539.424605753404;60222.698886505284;60241;52081.47918520766;53529.19706204488;53887.461125389025;54441.1833822493;54816.72591637016;9012.188902998761;9055.139761722627;9166.67916622915;9185.77035574116;9399.577019034023;40734.16696248617;41242.38136427896;41733;41803.58196417997;42285.15429691327;49003.26495102505;51795.74102129465;53036;53307.73346133244;53555.73222133864;8967.730968070968;8970.37207395476;8998.325125615736;9020.503872287087;9234.815303693755;12300.630981070582;12835.294058826854;12861.485540578273;13019.21884686884;13367.532136375568;11283.210175287652;11570.363630000094;11623.6512904613;11634.36011019402;11800.350980696145;11023.61417350389;11034.668959931216;11088.501017454073;11117.27737697047;11221.887781122085;10960.725981850199;11069.169812264274;11150.442477876237;11270.267432617182;11282;9854;9892.455914924749;9898.851517227104;9931;10546.156307495228;9655.855162172433;9764.218862491125;9828.262880283864;9887.802243954937;9955.601775928882 14:15:59 INFO - 2016-01-07 14:15:59,715 DEBUG : BROWSER_OUTPUT: __end_tp_report 14:15:59 INFO - 2016-01-07 14:15:59,715 DEBUG : BROWSER_OUTPUT: __start_cc_report 14:15:59 INFO - 2016-01-07 14:15:59,715 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,708 14:15:59 INFO - 2016-01-07 14:15:59,715 DEBUG : BROWSER_OUTPUT: __end_cc_report 14:15:59 INFO - 2016-01-07 14:15:59,715 DEBUG : BROWSER_OUTPUT: __startTimestamp1452204959700__endTimestamp 14:15:59 INFO - 2016-01-07 14:15:59,715 DEBUG : BROWSER_OUTPUT: 14:15:59 INFO - 2016-01-07 14:15:59,715 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 14:15:59 INFO - 2016-01-07 14:15:59,715 DEBUG : BROWSER_OUTPUT: Number of tests: 6 14:15:59 INFO - 2016-01-07 14:15:59,715 DEBUG : BROWSER_OUTPUT: 14:15:59 INFO - 2016-01-07 14:15:59,715 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:5715.58 Median:5950.29 stddev:640.00 (10.8%) stddev-sans-first:613.02 14:15:59 INFO - 2016-01-07 14:15:59,716 DEBUG : BROWSER_OUTPUT: Values: 3289.8 3432.2 3462.9 3467.2 3492.8 5611.9 5640.1 5643.8 5672.0 5685.9 5635.4 5681.4 5684.1 5695.0 5714.9 5009.7 5150.7 5166.3 5252.3 5326.8 5215.9 5224.5 5224.6 5231.9 5242.1 5123.1 5149.0 5234.6 5272.4 5297.8 5341.7 5395.8 5396.8 5402.4 5406.3 5032.1 5282.7 5292.8 5320.1 5341.8 5438.6 5447.5 5526.0 5533.3 5554.6 6184.9 6190.9 6235.4 6243.3 6254.5 6031.6 6092.2 6257.4 6280.6 6288.4 5663.4 5744.5 5752.2 5752.6 5779.8 6263.1 6279.8 6281.8 6282.2 6284.6 5927.4 5995.7 6025.2 6099.3 6111.8 6139.8 6143.5 6265.1 6269.2 6272.4 6206.9 6218.8 6221.7 6222.3 6234.8 5968.3 6053.2 6069.9 6178.1 6197.3 4698.6 4710.8 4711.0 4731.5 4735.7 4176.4 4181.0 4189.6 4193.9 4201.0 5724.8 5734.9 5812.6 5821.4 5836.9 6130.8 6190.4 6198.0 6198.5 6202.1 5835.1 5844.6 5847.9 5851.3 5876.0 5221.5 5275.9 5306.3 5392.2 5414.0 6340.7 6342.4 6343.9 6346.1 6348.7 6037.8 6170.7 6176.1 6178.2 6185.8 6127.7 6201.4 6319.8 6332.6 6343.8 6044.3 6160.0 6169.2 6172.8 6190.4 6014.2 6114.6 6171.9 6204.8 6205.3 5883.4 5940.5 5947.8 5950.3 5969.4 5973.5 6026.1 6049.5 6070.1 6072.5 5823.5 5826.4 5936.7 5960.1 5990.3 6022.8 6128.3 6130.8 6133.6 6134.2 5983.2 5997.4 6000.2 6002.1 6021.8 14:15:59 INFO - 2016-01-07 14:15:59,716 DEBUG : BROWSER_OUTPUT: 14:15:59 INFO - 2016-01-07 14:15:59,716 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:56516.67 Median:37287.86 stddev:99837.58 (267.7%) stddev-sans-first:100029.27 14:15:59 INFO - 2016-01-07 14:15:59,716 DEBUG : BROWSER_OUTPUT: Values: 566.4 599.1 601.2 605.4 624.6 35828.6 44900.6 45652.3 45746.3 45796.8 47598.8 48187.8 48219.8 48229.8 48277.0 8237.9 8377.2 8910.7 9212.2 10532.5 10775.6 10930.4 10938.6 10940.8 10945.0 10905.4 11020.0 11023.3 11031.8 11039.9 10781.3 10816.3 10860.1 10862.9 10885.0 10659.1 10838.8 10840.2 10847.7 10868.4 46366.0 46876.0 47006.3 47018.3 47045.5 3578.3 3615.7 3659.3 3801.3 4162.6 33321.3 33370.7 33376.0 33435.2 33456.2 3978.4 4010.7 4060.2 4090.8 4118.3 316766.0 316900.0 317730.0 317818.0 319632.0 66864.7 68427.0 70769.0 75233.0 77549.6 70811.3 70839.0 70864.6 70926.0 71187.6 18074.5 18111.0 18223.3 18241.1 18262.6 12607.8 12626.7 12642.0 12652.7 12717.4 23130.2 23428.2 23442.2 23479.0 23521.0 8605.1 8704.4 8710.1 8778.6 8797.7 892.7 956.6 987.8 997.9 1093.6 28426.7 34561.8 35120.8 35209.8 35353.6 1086.3 1117.3 1122.1 1123.9 1162.6 14109.4 15991.3 16107.9 16198.3 18209.3 465798.0 471509.0 472679.0 473045.0 475048.0 63239.0 63298.7 63591.0 63869.4 63908.0 1346.8 1407.9 1447.8 1481.2 1487.0 31932.0 31942.4 32046.0 32397.7 32690.0 52535.5 52710.0 53150.0 53232.5 53335.2 327823.0 329444.0 329677.0 329771.0 330983.0 36894.4 37198.8 37285.3 37583.4 37751.0 48672.3 48989.8 49534.0 50111.5 50162.0 39229.6 39518.4 39758.4 40264.6 41104.8 40530.6 41489.2 41636.0 42349.6 42549.0 41149.6 41357.4 41393.8 43499.6 44186.0 35696.5 37149.8 37290.5 37857.2 38096.2 26414.7 26798.2 26854.8 26946.5 27105.9 14:15:59 INFO - 2016-01-07 14:15:59,716 DEBUG : BROWSER_OUTPUT: 14:15:59 INFO - 2016-01-07 14:15:59,716 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:30489.98 Median:4679.22 stddev:101176.81 (2162.3%) stddev-sans-first:101435.36 14:15:59 INFO - 2016-01-07 14:15:59,716 DEBUG : BROWSER_OUTPUT: Values: 373.1 374.0 381.4 381.6 385.2 15105.2 16573.5 17281.2 19630.6 19651.4 13712.3 14045.0 14084.2 19808.4 20073.0 4930.6 5050.2 5051.0 5051.3 5055.0 3917.2 3947.6 5006.2 5267.3 5424.1 5321.8 5341.9 5352.0 5356.8 5369.8 5226.5 5335.6 5355.9 5356.7 5359.5 4661.6 4675.3 4676.4 4679.0 4679.4 14560.3 14950.7 15375.2 15481.2 15501.6 2129.1 2147.1 2215.5 2252.8 2274.9 10684.9 10828.2 10938.7 11014.8 11044.4 1808.4 1908.8 1920.1 1927.8 1932.4 67087.3 68162.3 69079.3 69142.0 70168.6 7886.1 7903.8 7934.3 7962.8 8006.4 9677.6 9758.5 9763.0 9769.7 9777.9 6308.5 6368.4 6383.6 6410.8 6439.8 6576.1 6582.4 6583.2 6629.3 6666.0 3683.1 3709.8 3719.1 3741.4 3741.9 1267.6 1270.6 1292.9 1293.3 1327.4 535.0 535.9 541.8 553.9 584.8 11682.6 12764.9 12921.9 13432.3 13458.0 560.1 568.1 577.6 580.9 583.5 7143.0 7223.7 7481.4 7499.3 7608.6 592442.0 609216.0 610839.0 634033.0 638993.0 82965.0 84635.0 84682.0 87191.0 87384.0 603.9 615.0 620.1 621.0 621.0 11883.8 12261.0 12467.1 12475.1 12732.5 38389.0 38591.0 39224.6 39250.8 39274.2 48805.8 49249.5 53744.0 53985.0 55958.0 7592.0 7682.5 7683.6 7722.7 7767.7 11434.1 11754.2 13148.5 13476.9 13569.4 11172.7 11813.7 11851.4 11852.0 11908.0 11195.7 11312.6 11335.2 11369.5 11609.3 11792.2 11905.2 11910.5 11945.8 12237.1 7701.2 7798.4 7815.4 7860.0 7909.8 12104.2 12192.3 12229.9 12242.9 12429.0 14:15:59 INFO - 2016-01-07 14:15:59,716 DEBUG : BROWSER_OUTPUT: 14:15:59 INFO - 2016-01-07 14:15:59,716 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5915.59 Median:6332.24 stddev:3080.62 (48.6%) stddev-sans-first:3071.89 14:15:59 INFO - 2016-01-07 14:15:59,716 DEBUG : BROWSER_OUTPUT: Values: 1563.7 1568.5 1826.3 1890.5 1891.0 7600.3 7716.2 8291.8 8468.8 8471.5 7905.6 8041.2 8097.4 8136.8 8176.9 2436.7 2491.3 2491.8 2494.8 2495.2 2130.5 2163.6 2465.6 2474.7 2544.0 2469.1 2495.1 2506.5 2541.3 2542.8 2394.7 2399.7 2427.4 2427.4 2430.2 2472.5 2497.7 2499.4 2500.4 2501.2 8416.8 8511.0 8515.4 8519.0 8525.9 5162.4 5203.9 5216.2 5216.4 5250.4 3329.6 3418.6 3438.7 3442.0 3468.4 1173.5 1194.8 1197.2 1221.1 1231.0 11680.1 11798.8 11826.8 11828.6 11833.0 4806.4 4825.2 4854.7 4925.4 4937.7 9355.9 9376.7 9397.5 9427.4 9436.5 5112.0 5117.5 5123.9 5127.2 5130.6 4737.4 4740.7 4747.9 4750.5 4751.2 3311.5 3785.8 3790.3 3809.1 3821.7 1090.5 1149.7 1163.2 1175.7 1194.7 1119.7 1160.8 1167.9 1449.9 1515.2 7999.4 8035.4 8038.4 8058.7 8068.9 786.3 794.4 796.5 797.9 909.8 6312.6 6351.9 6415.5 6428.3 6438.0 10116.7 10339.7 10360.9 10382.2 10416.6 10095.7 10300.9 10325.7 10331.6 10351.4 7959.8 8024.4 8026.6 8035.5 8040.9 7657.6 7666.8 7698.3 7733.7 7849.6 9153.8 9274.4 9342.8 9348.0 9369.8 9338.3 9485.5 9508.1 9591.1 9614.9 7018.6 7069.7 7085.0 7088.4 7089.1 7479.7 7637.2 7984.5 8145.7 8164.3 7483.4 7621.4 7666.4 7715.0 7814.2 7506.8 7553.0 7622.0 7687.8 7695.6 7636.7 7657.3 7697.1 7811.6 7829.2 6839.9 6884.3 6898.4 6899.3 6899.5 7076.3 7132.8 7138.1 7164.7 7191.5 14:15:59 INFO - 2016-01-07 14:15:59,716 DEBUG : BROWSER_OUTPUT: 14:15:59 INFO - 2016-01-07 14:15:59,716 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:5246.02 Median:5943.76 stddev:1531.00 (25.8%) stddev-sans-first:1490.69 14:15:59 INFO - 2016-01-07 14:15:59,717 DEBUG : BROWSER_OUTPUT: Values: 358.0 360.7 361.5 363.7 363.8 5710.4 5834.2 5844.0 5875.3 5883.7 5685.7 5787.9 5789.2 5816.4 5818.0 4580.0 4597.0 4614.6 4615.4 4622.8 4428.7 4501.1 4513.7 4609.7 4614.2 4558.4 4561.6 4574.0 4592.8 4593.9 4527.3 4538.5 4553.2 4560.8 4564.0 4046.6 4050.4 4057.4 4060.4 4061.0 5562.2 5645.1 5647.3 5660.9 5663.9 5296.5 5298.1 5313.3 5313.9 5318.4 5943.0 6259.0 6261.9 6264.1 6273.2 4325.6 4387.4 4421.7 4427.2 4435.4 6296.4 6359.6 6394.8 6409.5 6419.0 4540.2 4545.4 4565.8 4568.6 4574.5 4565.3 4627.4 4637.2 4647.7 4686.8 5299.8 5304.9 5309.9 5311.6 5312.9 6237.0 6237.2 6239.2 6244.4 6256.4 1656.4 1675.9 1680.9 1681.6 1682.5 1127.4 1130.0 1131.7 1138.3 1164.7 6044.4 6059.2 6062.3 6064.6 6072.9 6310.9 6365.2 6369.9 6376.9 6389.5 5944.6 5996.6 6054.9 6057.8 6063.5 3515.8 3537.0 3537.4 3540.1 3542.6 6480.7 6482.3 6487.8 6491.6 6492.3 6498.8 6504.7 6508.9 6510.9 6517.9 6441.6 6654.3 6663.2 6675.9 6677.1 6266.4 6347.4 6481.2 6482.4 6494.5 6271.1 6339.0 6364.6 6374.6 6375.2 6583.1 6603.0 6606.4 6618.2 6621.5 4526.0 4566.0 4568.2 4573.2 4573.5 6366.5 6376.8 6380.7 6386.6 6388.3 6274.2 6274.4 6277.3 6277.7 6285.6 6213.5 6263.2 6263.3 6269.8 6270.4 6194.8 6201.2 6206.6 6207.3 6208.7 6266.0 6289.8 6301.2 6308.4 6328.0 6096.1 6112.3 6174.6 6177.3 6183.7 14:15:59 INFO - 2016-01-07 14:15:59,717 DEBUG : BROWSER_OUTPUT: 14:15:59 INFO - 2016-01-07 14:15:59,717 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:14988.23 Median:504.51 stddev:18254.36 (3618.2%) stddev-sans-first:18274.62 14:15:59 INFO - 2016-01-07 14:15:59,718 DEBUG : BROWSER_OUTPUT: Values: 833.7 870.6 889.6 938.1 958.0 15041.7 15533.3 15536.1 15559.6 15567.5 14195.9 14286.8 14375.9 14376.9 14385.3 905.8 913.2 920.4 921.2 922.6 895.9 903.2 904.9 905.8 906.9 952.4 960.0 961.9 962.0 962.4 954.2 954.3 955.2 955.5 956.4 703.8 705.5 705.7 705.9 706.3 14091.2 14145.4 14179.5 14243.7 14266.4 11339.9 11598.7 11661.3 12015.9 12029.3 10063.8 10459.3 10631.4 10631.5 10705.5 3722.6 3726.8 3758.8 3803.3 3812.4 44976.8 46307.8 50092.2 50192.7 51757.7 10518.4 10752.3 10864.1 10908.7 11132.7 13259.3 13415.9 21044.9 21053.6 21061.8 7349.6 7406.4 7526.8 7557.3 7648.7 4446.1 4876.9 4892.9 4965.1 4976.5 3063.5 3067.8 3077.9 3082.7 3087.2 489.0 493.3 501.8 502.5 506.5 711.8 724.5 752.2 755.9 760.1 8718.2 8778.3 8834.3 8879.9 8897.3 589.0 658.1 742.6 750.6 757.1 4039.2 4049.0 4123.6 4157.6 4195.3 65746.7 68270.7 69372.7 69613.0 69890.7 46620.0 54202.5 57539.4 60222.7 60241.0 52081.5 53529.2 53887.5 54441.2 54816.7 9012.2 9055.1 9166.7 9185.8 9399.6 40734.2 41242.4 41733.0 41803.6 42285.2 49003.3 51795.7 53036.0 53307.7 53555.7 8967.7 8970.4 8998.3 9020.5 9234.8 12300.6 12835.3 12861.5 13019.2 13367.5 11283.2 11570.4 11623.7 11634.4 11800.4 11023.6 11034.7 11088.5 11117.3 11221.9 10960.7 11069.2 11150.4 11270.3 11282.0 9854.0 9892.5 9898.9 9931.0 10546.2 9655.9 9764.2 9828.3 9887.8 9955.6 14:15:59 INFO - 2016-01-07 14:15:59,718 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 14:15:59 INFO - 2016-01-07 14:15:59,718 DEBUG : BROWSER_OUTPUT: 14:16:00 INFO - 2016-01-07 14:16:00,345 INFO : Browser exited with error code: 0 14:16:00 INFO - 2016-01-07 14:16:00,369 INFO : Completed test dromaeo_css (00:18:29) 14:16:00 INFO - 2016-01-07 14:16:00,369 INFO : Starting test kraken 14:16:00 INFO - 2016-01-07 14:16:00,369 DEBUG : operating with platform_type : linux_ 14:16:00 INFO - 2016-01-07 14:16:00,369 INFO : Initialising browser for kraken test... 14:16:00 INFO - 2016-01-07 14:16:00,375 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpQ1Eohx/profile http://localhost:52532/getInfo.html 14:16:03 INFO - 2016-01-07 14:16:03,873 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 14:16:03 INFO - 2016-01-07 14:16:03,873 DEBUG : BROWSER_OUTPUT: colorDepth:24 14:16:03 INFO - 2016-01-07 14:16:03,874 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 14:16:03 INFO - 2016-01-07 14:16:03,874 DEBUG : BROWSER_OUTPUT: __metrics 14:16:04 INFO - 2016-01-07 14:16:04,039 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 14:16:05 INFO - 2016-01-07 14:16:05,317 INFO : Browser initialized. 14:16:05 INFO - 2016-01-07 14:16:05,318 INFO : Running cycle 1/1 for kraken test... 14:16:05 INFO - 2016-01-07 14:16:05,318 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpQ1Eohx/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 14:16:16 INFO - 2016-01-07 14:16:16,799 DEBUG : BROWSER_OUTPUT: RSS: Main: 128610304 14:16:16 INFO - 2016-01-07 14:16:16,799 DEBUG : BROWSER_OUTPUT: 14:16:19 INFO - 2016-01-07 14:16:19,239 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52532/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:52532/tests/kraken/driver.html?testName=audio-beat-detection) 14:16:19 INFO - 2016-01-07 14:16:19,811 DEBUG : BROWSER_OUTPUT: RSS: Main: 162226176 14:16:19 INFO - 2016-01-07 14:16:19,812 DEBUG : BROWSER_OUTPUT: 14:16:22 INFO - 2016-01-07 14:16:22,382 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52532/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:52532/tests/kraken/driver.html?testName=audio-dft) 14:16:22 INFO - 2016-01-07 14:16:22,943 DEBUG : BROWSER_OUTPUT: RSS: Main: 160849920 14:16:22 INFO - 2016-01-07 14:16:22,944 DEBUG : BROWSER_OUTPUT: 14:16:25 INFO - 2016-01-07 14:16:25,725 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52532/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:52532/tests/kraken/driver.html?testName=audio-fft) 14:16:26 INFO - 2016-01-07 14:16:26,286 DEBUG : BROWSER_OUTPUT: RSS: Main: 158167040 14:16:26 INFO - 2016-01-07 14:16:26,286 DEBUG : BROWSER_OUTPUT: 14:16:28 INFO - 2016-01-07 14:16:28,224 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52532/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:52532/tests/kraken/driver.html?testName=audio-oscillator) 14:16:28 INFO - 2016-01-07 14:16:28,787 DEBUG : BROWSER_OUTPUT: RSS: Main: 158048256 14:16:28 INFO - 2016-01-07 14:16:28,787 DEBUG : BROWSER_OUTPUT: 14:16:30 INFO - 2016-01-07 14:16:30,945 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52532/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:52532/tests/kraken/driver.html?testName=imaging-gaussian-blur) 14:16:31 INFO - 2016-01-07 14:16:31,497 DEBUG : BROWSER_OUTPUT: RSS: Main: 157409280 14:16:31 INFO - 2016-01-07 14:16:31,498 DEBUG : BROWSER_OUTPUT: 14:16:34 INFO - 2016-01-07 14:16:34,398 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52532/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:52532/tests/kraken/driver.html?testName=imaging-darkroom) 14:16:34 INFO - 2016-01-07 14:16:34,959 DEBUG : BROWSER_OUTPUT: RSS: Main: 156307456 14:16:34 INFO - 2016-01-07 14:16:34,959 DEBUG : BROWSER_OUTPUT: 14:16:38 INFO - 2016-01-07 14:16:38,294 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52532/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:52532/tests/kraken/driver.html?testName=imaging-desaturate) 14:16:38 INFO - 2016-01-07 14:16:38,861 DEBUG : BROWSER_OUTPUT: RSS: Main: 157478912 14:16:38 INFO - 2016-01-07 14:16:38,861 DEBUG : BROWSER_OUTPUT: 14:16:41 INFO - 2016-01-07 14:16:41,600 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52532/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:52532/tests/kraken/driver.html?testName=json-parse-financial) 14:16:42 INFO - 2016-01-07 14:16:42,166 DEBUG : BROWSER_OUTPUT: RSS: Main: 157454336 14:16:42 INFO - 2016-01-07 14:16:42,166 DEBUG : BROWSER_OUTPUT: 14:16:43 INFO - 2016-01-07 14:16:43,674 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52532/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:52532/tests/kraken/driver.html?testName=json-stringify-tinderbox) 14:16:44 INFO - 2016-01-07 14:16:44,228 DEBUG : BROWSER_OUTPUT: RSS: Main: 161751040 14:16:44 INFO - 2016-01-07 14:16:44,228 DEBUG : BROWSER_OUTPUT: 14:16:45 INFO - 2016-01-07 14:16:45,963 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52532/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:52532/tests/kraken/driver.html?testName=stanford-crypto-aes) 14:16:46 INFO - 2016-01-07 14:16:46,557 DEBUG : BROWSER_OUTPUT: RSS: Main: 161169408 14:16:46 INFO - 2016-01-07 14:16:46,557 DEBUG : BROWSER_OUTPUT: 14:16:48 INFO - 2016-01-07 14:16:48,470 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52532/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:52532/tests/kraken/driver.html?testName=stanford-crypto-ccm) 14:16:49 INFO - 2016-01-07 14:16:49,037 DEBUG : BROWSER_OUTPUT: RSS: Main: 166821888 14:16:49 INFO - 2016-01-07 14:16:49,037 DEBUG : BROWSER_OUTPUT: 14:16:51 INFO - 2016-01-07 14:16:51,342 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52532/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:52532/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 14:16:51 INFO - 2016-01-07 14:16:51,924 DEBUG : BROWSER_OUTPUT: RSS: Main: 171720704 14:16:51 INFO - 2016-01-07 14:16:51,924 DEBUG : BROWSER_OUTPUT: 14:16:54 INFO - 2016-01-07 14:16:54,323 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52532/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:52532/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 14:16:54 INFO - 2016-01-07 14:16:54,885 DEBUG : BROWSER_OUTPUT: RSS: Main: 170344448 14:16:54 INFO - 2016-01-07 14:16:54,885 DEBUG : BROWSER_OUTPUT: 14:16:56 INFO - 2016-01-07 14:16:56,494 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52532/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:52532/tests/kraken/driver.html?testName=ai-astar) 14:16:56 INFO - 2016-01-07 14:16:56,744 DEBUG : BROWSER_OUTPUT: RSS: Main: 227946496 14:16:56 INFO - 2016-01-07 14:16:56,744 DEBUG : BROWSER_OUTPUT: 14:16:56 INFO - 2016-01-07 14:16:56,745 DEBUG : BROWSER_OUTPUT: __start_tp_report 14:16:56 INFO - 2016-01-07 14:16:56,745 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 14:16:56 INFO - 2016-01-07 14:16:56,746 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 14:16:56 INFO - 2016-01-07 14:16:56,746 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 14:16:56 INFO - 2016-01-07 14:16:56,746 DEBUG : BROWSER_OUTPUT: |0;ai-astar;109;112;102;112;112;111;99;109;100;108 14:16:56 INFO - 2016-01-07 14:16:56,746 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;152;125;146;161;131;159;147;126;158;123 14:16:56 INFO - 2016-01-07 14:16:56,746 DEBUG : BROWSER_OUTPUT: |2;audio-dft;161;162;162;162;162;163;161;164;160;163 14:16:56 INFO - 2016-01-07 14:16:56,746 DEBUG : BROWSER_OUTPUT: |3;audio-fft;71;72;71;148;72;72;72;71;148;72 14:16:56 INFO - 2016-01-07 14:16:56,746 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;91;90;138;90;90;90;133;88;90;134 14:16:56 INFO - 2016-01-07 14:16:56,746 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;110;110;109;109;109;110;110;110;109;110 14:16:56 INFO - 2016-01-07 14:16:56,747 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;147;145;144;146;145;145;145;145;145;144 14:16:56 INFO - 2016-01-07 14:16:56,747 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;96;96;96;96;95;96;95;96;95;96 14:16:56 INFO - 2016-01-07 14:16:56,747 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;53;54;55;55;57;55;57;63;54;54 14:16:56 INFO - 2016-01-07 14:16:56,747 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;63;64;64;64;63;64;64;63;67;64 14:16:56 INFO - 2016-01-07 14:16:56,747 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;77;76;78;78;77;77;76;78;77;77 14:16:56 INFO - 2016-01-07 14:16:56,747 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;115;111;108;122;114;110;124;111;110;107 14:16:56 INFO - 2016-01-07 14:16:56,747 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;135;137;133;136;141;138;136;137;135;129 14:16:56 INFO - 2016-01-07 14:16:56,748 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;62;62;63;64;63;64;63;60;64;61 14:16:56 INFO - 2016-01-07 14:16:56,748 DEBUG : BROWSER_OUTPUT: __end_tp_report 14:16:56 INFO - 2016-01-07 14:16:56,748 DEBUG : BROWSER_OUTPUT: __start_cc_report 14:16:56 INFO - 2016-01-07 14:16:56,748 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,861 14:16:56 INFO - 2016-01-07 14:16:56,748 DEBUG : BROWSER_OUTPUT: __end_cc_report 14:16:56 INFO - 2016-01-07 14:16:56,748 DEBUG : BROWSER_OUTPUT: __startTimestamp1452205016744__endTimestamp 14:16:56 INFO - 2016-01-07 14:16:56,748 DEBUG : BROWSER_OUTPUT: 14:16:56 INFO - 2016-01-07 14:16:56,752 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 14:16:56 INFO - 2016-01-07 14:16:56,752 DEBUG : BROWSER_OUTPUT: Number of tests: 14 14:16:56 INFO - 2016-01-07 14:16:56,752 DEBUG : BROWSER_OUTPUT: 14:16:56 INFO - 2016-01-07 14:16:56,752 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:107.40 Median:111.50 stddev:5.13 (4.6%) stddev-sans-first:5.40 14:16:56 INFO - 2016-01-07 14:16:56,752 DEBUG : BROWSER_OUTPUT: Values: 109.0 112.0 102.0 112.0 112.0 111.0 99.0 109.0 100.0 108.0 14:16:56 INFO - 2016-01-07 14:16:56,753 DEBUG : BROWSER_OUTPUT: 14:16:56 INFO - 2016-01-07 14:16:56,753 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:142.80 Median:149.50 stddev:15.16 (10.1%) stddev-sans-first:15.71 14:16:56 INFO - 2016-01-07 14:16:56,753 DEBUG : BROWSER_OUTPUT: Values: 152.0 125.0 146.0 161.0 131.0 159.0 147.0 126.0 158.0 123.0 14:16:56 INFO - 2016-01-07 14:16:56,753 DEBUG : BROWSER_OUTPUT: 14:16:56 INFO - 2016-01-07 14:16:56,753 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:162.00 Median:162.00 stddev:1.15 (0.7%) stddev-sans-first:1.17 14:16:56 INFO - 2016-01-07 14:16:56,753 DEBUG : BROWSER_OUTPUT: Values: 161.0 162.0 162.0 162.0 162.0 163.0 161.0 164.0 160.0 163.0 14:16:56 INFO - 2016-01-07 14:16:56,754 DEBUG : BROWSER_OUTPUT: 14:16:56 INFO - 2016-01-07 14:16:56,754 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:86.90 Median:72.00 stddev:32.21 (44.7%) stddev-sans-first:33.64 14:16:56 INFO - 2016-01-07 14:16:56,754 DEBUG : BROWSER_OUTPUT: Values: 71.0 72.0 71.0 148.0 72.0 72.0 72.0 71.0 148.0 72.0 14:16:56 INFO - 2016-01-07 14:16:56,754 DEBUG : BROWSER_OUTPUT: 14:16:56 INFO - 2016-01-07 14:16:56,754 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:103.40 Median:90.00 stddev:21.85 (24.3%) stddev-sans-first:22.71 14:16:56 INFO - 2016-01-07 14:16:56,755 DEBUG : BROWSER_OUTPUT: Values: 91.0 90.0 138.0 90.0 90.0 90.0 133.0 88.0 90.0 134.0 14:16:56 INFO - 2016-01-07 14:16:56,755 DEBUG : BROWSER_OUTPUT: 14:16:56 INFO - 2016-01-07 14:16:56,755 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:109.60 Median:110.00 stddev:0.52 (0.5%) stddev-sans-first:0.53 14:16:56 INFO - 2016-01-07 14:16:56,755 DEBUG : BROWSER_OUTPUT: Values: 110.0 110.0 109.0 109.0 109.0 110.0 110.0 110.0 109.0 110.0 14:16:56 INFO - 2016-01-07 14:16:56,755 DEBUG : BROWSER_OUTPUT: 14:16:56 INFO - 2016-01-07 14:16:56,757 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:145.10 Median:145.00 stddev:0.88 (0.6%) stddev-sans-first:0.60 14:16:56 INFO - 2016-01-07 14:16:56,757 DEBUG : BROWSER_OUTPUT: Values: 147.0 145.0 144.0 146.0 145.0 145.0 145.0 145.0 145.0 144.0 14:16:56 INFO - 2016-01-07 14:16:56,757 DEBUG : BROWSER_OUTPUT: 14:16:56 INFO - 2016-01-07 14:16:56,757 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:95.70 Median:96.00 stddev:0.48 (0.5%) stddev-sans-first:0.50 14:16:56 INFO - 2016-01-07 14:16:56,757 DEBUG : BROWSER_OUTPUT: Values: 96.0 96.0 96.0 96.0 95.0 96.0 95.0 96.0 95.0 96.0 14:16:56 INFO - 2016-01-07 14:16:56,757 DEBUG : BROWSER_OUTPUT: 14:16:56 INFO - 2016-01-07 14:16:56,757 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:55.70 Median:55.00 stddev:2.87 (5.2%) stddev-sans-first:2.87 14:16:56 INFO - 2016-01-07 14:16:56,758 DEBUG : BROWSER_OUTPUT: Values: 53.0 54.0 55.0 55.0 57.0 55.0 57.0 63.0 54.0 54.0 14:16:56 INFO - 2016-01-07 14:16:56,758 DEBUG : BROWSER_OUTPUT: 14:16:56 INFO - 2016-01-07 14:16:56,758 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:64.00 Median:64.00 stddev:1.15 (1.8%) stddev-sans-first:1.17 14:16:56 INFO - 2016-01-07 14:16:56,758 DEBUG : BROWSER_OUTPUT: Values: 63.0 64.0 64.0 64.0 63.0 64.0 64.0 63.0 67.0 64.0 14:16:56 INFO - 2016-01-07 14:16:56,758 DEBUG : BROWSER_OUTPUT: 14:16:56 INFO - 2016-01-07 14:16:56,758 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:77.10 Median:77.00 stddev:0.74 (1.0%) stddev-sans-first:0.78 14:16:56 INFO - 2016-01-07 14:16:56,758 DEBUG : BROWSER_OUTPUT: Values: 77.0 76.0 78.0 78.0 77.0 77.0 76.0 78.0 77.0 77.0 14:16:56 INFO - 2016-01-07 14:16:56,758 DEBUG : BROWSER_OUTPUT: 14:16:56 INFO - 2016-01-07 14:16:56,759 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:113.20 Median:112.50 stddev:5.71 (5.1%) stddev-sans-first:6.02 14:16:56 INFO - 2016-01-07 14:16:56,759 DEBUG : BROWSER_OUTPUT: Values: 115.0 111.0 108.0 122.0 114.0 110.0 124.0 111.0 110.0 107.0 14:16:56 INFO - 2016-01-07 14:16:56,759 DEBUG : BROWSER_OUTPUT: 14:16:56 INFO - 2016-01-07 14:16:56,759 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:135.70 Median:136.50 stddev:3.16 (2.3%) stddev-sans-first:3.35 14:16:56 INFO - 2016-01-07 14:16:56,759 DEBUG : BROWSER_OUTPUT: Values: 135.0 137.0 133.0 136.0 141.0 138.0 136.0 137.0 135.0 129.0 14:16:56 INFO - 2016-01-07 14:16:56,759 DEBUG : BROWSER_OUTPUT: 14:16:56 INFO - 2016-01-07 14:16:56,759 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:62.60 Median:63.00 stddev:1.35 (2.1%) stddev-sans-first:1.41 14:16:56 INFO - 2016-01-07 14:16:56,760 DEBUG : BROWSER_OUTPUT: Values: 62.0 62.0 63.0 64.0 63.0 64.0 63.0 60.0 64.0 61.0 14:16:56 INFO - 2016-01-07 14:16:56,760 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 14:16:56 INFO - 2016-01-07 14:16:56,760 DEBUG : BROWSER_OUTPUT: 14:16:57 INFO - 2016-01-07 14:16:57,401 INFO : Browser exited with error code: 0 14:16:57 INFO - 2016-01-07 14:16:57,459 INFO : Completed test kraken (00:00:57) 14:16:57 INFO - 2016-01-07 14:16:57,459 INFO : Starting test v8_7 14:16:57 INFO - 2016-01-07 14:16:57,459 DEBUG : operating with platform_type : linux_ 14:16:57 INFO - 2016-01-07 14:16:57,460 INFO : Initialising browser for v8_7 test... 14:16:57 INFO - 2016-01-07 14:16:57,466 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp2CR_Lh/profile http://localhost:52532/getInfo.html 14:17:01 INFO - 2016-01-07 14:17:01,017 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 14:17:01 INFO - 2016-01-07 14:17:01,017 DEBUG : BROWSER_OUTPUT: colorDepth:24 14:17:01 INFO - 2016-01-07 14:17:01,018 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 14:17:01 INFO - 2016-01-07 14:17:01,018 DEBUG : BROWSER_OUTPUT: __metrics 14:17:01 INFO - 2016-01-07 14:17:01,159 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 14:17:02 INFO - 2016-01-07 14:17:02,401 INFO : Browser initialized. 14:17:02 INFO - 2016-01-07 14:17:02,402 INFO : Running cycle 1/1 for v8_7 test... 14:17:02 INFO - 2016-01-07 14:17:02,402 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp2CR_Lh/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 14:17:13 INFO - 2016-01-07 14:17:13,940 DEBUG : BROWSER_OUTPUT: RSS: Main: 129425408 14:17:13 INFO - 2016-01-07 14:17:13,940 DEBUG : BROWSER_OUTPUT: 14:17:35 INFO - 2016-01-07 14:17:35,319 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52532/tests/v8_7/run.html (next: http://localhost:52532/tests/v8_7/run.html) 14:17:35 INFO - 2016-01-07 14:17:35,565 DEBUG : BROWSER_OUTPUT: RSS: Main: 428007424 14:17:35 INFO - 2016-01-07 14:17:35,566 DEBUG : BROWSER_OUTPUT: 14:17:35 INFO - 2016-01-07 14:17:35,567 DEBUG : BROWSER_OUTPUT: __start_tp_report 14:17:35 INFO - 2016-01-07 14:17:35,567 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 14:17:35 INFO - 2016-01-07 14:17:35,567 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 14:17:35 INFO - 2016-01-07 14:17:35,568 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 14:17:35 INFO - 2016-01-07 14:17:35,568 DEBUG : BROWSER_OUTPUT: |0;Richards;164.98927569707968 14:17:35 INFO - 2016-01-07 14:17:35,568 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;164.63615409944023 14:17:35 INFO - 2016-01-07 14:17:35,568 DEBUG : BROWSER_OUTPUT: |2;Encrypt;279.79854504756577 14:17:35 INFO - 2016-01-07 14:17:35,568 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5005 14:17:35 INFO - 2016-01-07 14:17:35,569 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1003.0090270812437 14:17:35 INFO - 2016-01-07 14:17:35,569 DEBUG : BROWSER_OUTPUT: |5;Earley;551.8763796909492 14:17:35 INFO - 2016-01-07 14:17:35,569 DEBUG : BROWSER_OUTPUT: |6;Boyer;10447.916666666666 14:17:35 INFO - 2016-01-07 14:17:35,569 DEBUG : BROWSER_OUTPUT: |7;RegExp;23627.906976744187 14:17:35 INFO - 2016-01-07 14:17:35,569 DEBUG : BROWSER_OUTPUT: |8;Splay;533.0490405117271 14:17:35 INFO - 2016-01-07 14:17:35,569 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4817.307692307692 14:17:35 INFO - 2016-01-07 14:17:35,569 DEBUG : BROWSER_OUTPUT: __end_tp_report 14:17:35 INFO - 2016-01-07 14:17:35,569 DEBUG : BROWSER_OUTPUT: __startTimestamp1452205055565__endTimestamp 14:17:35 INFO - 2016-01-07 14:17:35,569 DEBUG : BROWSER_OUTPUT: 14:17:35 INFO - 2016-01-07 14:17:35,570 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 14:17:35 INFO - 2016-01-07 14:17:35,570 DEBUG : BROWSER_OUTPUT: Number of tests: 10 14:17:35 INFO - 2016-01-07 14:17:35,570 DEBUG : BROWSER_OUTPUT: 14:17:35 INFO - 2016-01-07 14:17:35,570 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:164.99 Median:164.99 stddev:0.00 (0.0%) 14:17:35 INFO - 2016-01-07 14:17:35,570 DEBUG : BROWSER_OUTPUT: Values: 165.0 14:17:35 INFO - 2016-01-07 14:17:35,570 DEBUG : BROWSER_OUTPUT: 14:17:35 INFO - 2016-01-07 14:17:35,570 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:164.64 Median:164.64 stddev:0.00 (0.0%) 14:17:35 INFO - 2016-01-07 14:17:35,570 DEBUG : BROWSER_OUTPUT: Values: 164.6 14:17:35 INFO - 2016-01-07 14:17:35,570 DEBUG : BROWSER_OUTPUT: 14:17:35 INFO - 2016-01-07 14:17:35,570 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:279.80 Median:279.80 stddev:0.00 (0.0%) 14:17:35 INFO - 2016-01-07 14:17:35,570 DEBUG : BROWSER_OUTPUT: Values: 279.8 14:17:35 INFO - 2016-01-07 14:17:35,570 DEBUG : BROWSER_OUTPUT: 14:17:35 INFO - 2016-01-07 14:17:35,571 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5005.00 Median:5005.00 stddev:0.00 (0.0%) 14:17:35 INFO - 2016-01-07 14:17:35,571 DEBUG : BROWSER_OUTPUT: Values: 5005.0 14:17:35 INFO - 2016-01-07 14:17:35,571 DEBUG : BROWSER_OUTPUT: 14:17:35 INFO - 2016-01-07 14:17:35,571 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1003.01 Median:1003.01 stddev:0.00 (0.0%) 14:17:35 INFO - 2016-01-07 14:17:35,571 DEBUG : BROWSER_OUTPUT: Values: 1003.0 14:17:35 INFO - 2016-01-07 14:17:35,571 DEBUG : BROWSER_OUTPUT: 14:17:35 INFO - 2016-01-07 14:17:35,571 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:551.88 Median:551.88 stddev:0.00 (0.0%) 14:17:35 INFO - 2016-01-07 14:17:35,572 DEBUG : BROWSER_OUTPUT: Values: 551.9 14:17:35 INFO - 2016-01-07 14:17:35,572 DEBUG : BROWSER_OUTPUT: 14:17:35 INFO - 2016-01-07 14:17:35,572 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:10447.92 Median:10447.92 stddev:0.00 (0.0%) 14:17:35 INFO - 2016-01-07 14:17:35,572 DEBUG : BROWSER_OUTPUT: Values: 10447.9 14:17:35 INFO - 2016-01-07 14:17:35,572 DEBUG : BROWSER_OUTPUT: 14:17:35 INFO - 2016-01-07 14:17:35,573 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:23627.91 Median:23627.91 stddev:0.00 (0.0%) 14:17:35 INFO - 2016-01-07 14:17:35,573 DEBUG : BROWSER_OUTPUT: Values: 23627.9 14:17:35 INFO - 2016-01-07 14:17:35,573 DEBUG : BROWSER_OUTPUT: 14:17:35 INFO - 2016-01-07 14:17:35,573 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:533.05 Median:533.05 stddev:0.00 (0.0%) 14:17:35 INFO - 2016-01-07 14:17:35,573 DEBUG : BROWSER_OUTPUT: Values: 533.0 14:17:35 INFO - 2016-01-07 14:17:35,573 DEBUG : BROWSER_OUTPUT: 14:17:35 INFO - 2016-01-07 14:17:35,573 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4817.31 Median:4817.31 stddev:0.00 (0.0%) 14:17:35 INFO - 2016-01-07 14:17:35,573 DEBUG : BROWSER_OUTPUT: Values: 4817.3 14:17:35 INFO - 2016-01-07 14:17:35,574 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 14:17:35 INFO - 2016-01-07 14:17:35,574 DEBUG : BROWSER_OUTPUT: 14:17:36 INFO - 2016-01-07 14:17:36,269 INFO : Browser exited with error code: 0 14:17:36 INFO - 2016-01-07 14:17:36,281 INFO : Completed test v8_7 (00:00:38) 14:17:36 INFO - 2016-01-07 14:17:36,601 INFO : Completed test suite (00:20:06) 14:17:36 INFO - 2016-01-07 14:17:36,602 DEBUG : Working with test: dromaeo_css 14:17:36 INFO - 2016-01-07 14:17:36,602 DEBUG : Generating results file: dromaeo_css 14:17:36 INFO - 2016-01-07 14:17:36,603 DEBUG : Working with test: kraken 14:17:36 INFO - 2016-01-07 14:17:36,603 DEBUG : Generating results file: kraken 14:17:36 INFO - 2016-01-07 14:17:36,603 INFO : javascript benchmark 14:17:36 INFO - 2016-01-07 14:17:36,603 DEBUG : Working with test: v8_7 14:17:36 INFO - 2016-01-07 14:17:36,604 DEBUG : Generating results file: v8_7 14:17:36 INFO - 2016-01-07 14:17:36,604 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 14:17:36 INFO - 2016-01-07 14:17:36,655 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,53,35]] 14:17:36 INFO - 2016-01-07 14:17:36,656 DEBUG : process_Request line: dromaeo_css 7226.94 graph.html#tests=[[72,53,35]] 14:17:36 INFO - 2016-01-07 14:17:36,656 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 14:17:36 INFO - 2016-01-07 14:17:36,680 DEBUG : process_Request line: kraken 1461.20 graph.html#tests=[[232,53,35]] 14:17:36 INFO - 2016-01-07 14:17:36,680 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 14:17:36 INFO - 2016-01-07 14:17:36,707 DEBUG : process_Request line: v8_7 23270.16 graph.html#tests=[[230,53,35]] 14:17:36 INFO - 2016-01-07 14:17:36,708 INFO : javascript benchmark 14:17:36 INFO - 2016-01-07 14:17:36,712 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3289.7532685048623, 3432.1591210153483, 3462.948055779162, 3467.185211475303, 3492.8428220730066, 5611.887762244753, 5640.125780504023, 5643.8024669136585, 5672.035753921833, 5685.914711279329, 5635.351934527531, 5681.431856814327, 5684.090545512719, 5694.971525142379, 5714.942850571493, 5009.699418034911, 5150.716710580917, 5166.276721259027, 5252.264682944372, 5326.7869285228735, 5215.947840521584, 5224.477552244764, 5224.63427560071, 5231.947680523184, 5242.056429842627, 5123.052235336456, 5148.974255128738, 5234.607404444663, 5272.446393128724, 5297.814576489824, 5341.679499230039, 5395.78416863325, 5396.811111611114, 5402.405735369106, 5406.270153529283, 5032.144535428949, 5282.683039017671, 5292.788288468457, 5320.095583750772, 5341.813036543703, 5438.646487978269, 5447.45525447456, 5526.0, 5533.253010843525, 5554.638948468337, 6184.87630247397, 6190.876182476371, 6235.438810507076, 6243.313235544087, 6254.499640028832, 6031.577789554733, 6092.189959943392, 6257.374262573751, 6280.560360774748, 6288.402601752872, 5663.433656634304, 5744.454276843693, 5752.2234498342605, 5752.568557358215, 5779.826605201851, 6263.060540918898, 6279.780207692709, 6281.842953926189, 6282.183316168869, 6284.622922624657, 5927.436893495111, 5995.730192141364, 6025.216721826222, 6099.340948376802, 6111.755529778848, 6139.785107521305, 6143.508519318444, 6265.091561723524, 6269.185005949289, 6272.435480806749, 6206.875862482725, 6218.751249949952, 6221.688915554295, 6222.284437289679, 6234.812955611339, 5968.253968253968, 6053.243344581927, 6069.908951365733, 6178.073289006595, 6197.287311959182, 4698.624110071186, 4710.8351207707565, 4711.0, 4731.503192164773, 4735.668503204812, 4176.415301857743, 4181.0, 4189.6229339359, 4193.937090943638, 4200.957990420118, 5724.828255152269, 5734.856628584319, 5812.564057695605, 5821.417858214145, 5836.912446313224, 6130.754769809158, 6190.442860142609, 6198.039303907812, 6198.535109866778, 6202.100695399232, 5835.124731290341, 5844.561657875592, 5847.853803654858, 5851.268591426072, 5876.0, 5221.477852214824, 5275.868103297448, 5306.336707911511, 5392.191171324333, 5414.0, 6340.7463701451425, 6342.397472240037, 6343.873122537616, 6346.079818426302, 6348.746050157942, 6037.78867739627, 6170.6914654268, 6176.073588961512, 6178.1659475971965, 6185.84535386601, 6127.693615319127, 6201.441870231701, 6319.842003949938, 6332.556721029484, 6343.841403964938, 6044.304904935989, 6160.014397696347, 6169.167162433014, 6172.753089876534, 6190.442860142609, 6014.218151640259, 6114.597693712768, 6171.907421388593, 6204.81385558434, 6205.317415084247, 5883.352831188651, 5940.495057920125, 5947.762089516371, 5950.285965684146, 5969.3732158122775, 5973.462388384893, 6026.096085587197, 6049.51603871698, 6070.0591408331775, 6072.544559157993, 5823.534117270524, 5826.446487583673, 5936.732847021808, 5960.0761881908375, 5990.34106248321, 6022.759089636365, 6128.295246046761, 6130.754769809158, 6133.60131591463, 6134.2332208473945, 5983.222181116601, 5997.430244126801, 6000.249968753906, 6002.129691194839, 6021.849453763691], "unit": "ms", "name": "dojo.html", "value": 5673.60385697471}, {"lowerIsBetter": false, "replicates": [566.3515275010113, 599.0654578856982, 601.2184160591233, 605.4157737783039, 624.5752888036134, 35828.64171358286, 44900.55099449005, 45652.315215271796, 45746.31380529295, 45796.771016144914, 47598.76200618992, 48187.759061204735, 48219.758901205445, 48229.7588512057, 48277.0, 8237.876431853527, 8377.162283771635, 8910.732678019669, 9212.170904618582, 10532.47337633119, 10775.622853200139, 10930.398828064453, 10938.617148399808, 10940.835887461695, 10944.960228778253, 10905.400202988832, 11019.953104455064, 11023.283486573348, 11031.779364412707, 11039.944800275987, 10781.299215550964, 10816.296940698829, 10860.13118950482, 10862.891371086267, 10885.0, 10659.093977011964, 10838.837417438745, 10840.186985976005, 10847.67456976292, 10868.402237876913, 46366.0, 46876.0, 47006.29490557644, 47018.294725579144, 47045.529544704455, 3578.3022310649435, 3615.7288203384587, 3659.3413185626578, 3801.258754542865, 4162.646175075122, 33321.3335733284, 33370.666293336995, 33376.0, 33435.16412089693, 33456.16359591005, 3978.4430179774854, 4010.6590939770153, 4060.1879624075304, 4090.754554726726, 4118.320477121271, 316766.0, 316900.0, 317730.0, 317818.0, 319632.0, 66864.6656766713, 68427.0, 70769.0, 75233.0, 77549.61225193838, 70811.29188708047, 70839.0, 70864.64567677128, 70926.0, 71187.64406177936, 18074.457766267034, 18111.0, 18223.271069157352, 18241.087945602932, 18262.63474730498, 12607.810882836764, 12626.747465050648, 12642.0, 12652.746945061232, 12717.427715752814, 23130.19044333474, 23428.18001369944, 23442.17952371659, 23479.0, 23521.0, 8605.096464871098, 8704.390692651581, 8710.085441028728, 8778.60496277669, 8797.736067917973, 892.7009451833709, 956.5791051937265, 987.7678745494803, 997.9451130187764, 1093.5953697132113, 28426.715732842407, 34561.827190863885, 35120.82439587837, 35209.82395088008, 35353.64646353555, 1086.2939089591828, 1117.3072694929197, 1122.1247427006947, 1123.9100871930225, 1162.604714397109, 14109.435622574982, 15991.28039238237, 16107.919460402623, 16198.271077801528, 18209.271629134688, 465798.0, 471509.0, 472679.0, 473045.0, 475048.0, 63239.0, 63298.68350658217, 63591.0, 63869.36130638727, 63908.0, 1346.8451128120196, 1407.8592140786045, 1447.7683570628649, 1481.1853480585635, 1487.0408586461672, 31932.0, 31942.361152777277, 32046.0, 32397.676023239466, 32690.0, 52535.47464525306, 52710.0, 53150.0, 53232.467675322754, 53335.199971999675, 327823.0, 329444.0, 329677.0, 329771.0, 330983.0, 36894.44658330181, 37198.81400593088, 37285.25429491449, 37583.43624845684, 37750.979921606755, 48672.269915952, 48989.755051224514, 49534.0, 50111.498885012144, 50162.0, 39229.60770392259, 39518.40722389224, 39758.403623946244, 40264.59735402725, 41104.794476027426, 40530.594694052685, 41489.170216594895, 41636.0, 42349.57650423457, 42549.0, 41149.588504115774, 41357.37963930483, 41393.79303103465, 43499.56500434955, 44186.0, 35696.464553031205, 37149.814250928575, 37290.45603761432, 37857.24285514219, 38096.23807523779, 26414.735852641996, 26798.19605411841, 26854.78836309152, 26946.46107077808, 27105.86447067752], "unit": "ms", "name": "ext.html", "value": 21191.12407650407}, {"lowerIsBetter": false, "replicates": [373.1194381260227, 374.0368550981221, 381.44690199211135, 381.608850927799, 385.2429975098931, 15105.169215693133, 16573.50279491614, 17281.222344994472, 19630.607387852233, 19651.410457686292, 13712.314384280797, 14045.0, 14084.225367604779, 19808.40574782759, 20073.0, 4930.580900623451, 5050.191969284915, 5050.974745126269, 5051.3180720602795, 5055.014272216919, 3917.1969746202103, 3947.5657677655436, 5006.173981293082, 5267.315249017623, 5424.1321388577835, 5321.775991521952, 5341.866453338659, 5351.973240133794, 5356.785728570852, 5369.838904832861, 5226.477352264781, 5335.626506144571, 5355.892882142335, 5356.678599284036, 5359.490848369399, 4661.580457758818, 4675.275332323496, 4676.392069031038, 4679.0, 4679.438467383901, 14560.271986400743, 14950.700985980327, 15375.154366509838, 15481.225938703132, 15501.612459688598, 2129.1376992317983, 2147.133919639255, 2215.5125872308067, 2252.7972482476657, 2274.9090036398525, 10684.893151068467, 10828.187885908588, 10938.726531836688, 11014.834777478345, 11044.392558409285, 1808.3941879470394, 1908.809119088094, 1920.1455352368203, 1927.759030121235, 1932.3816378758802, 67087.3291267086, 68162.31837681659, 69079.30920690778, 69142.0, 70168.64915675389, 7886.132525422199, 7903.841923161504, 7934.325582325567, 7962.800929976681, 8006.439549231614, 9677.564509597085, 9758.512074396394, 9762.951185244028, 9769.658061967939, 9777.902220977841, 6308.495320374359, 6368.363163683687, 6383.585066970632, 6410.775622853178, 6439.839004024937, 6576.145101136822, 6582.407583317525, 6583.177102862142, 6629.3370662934285, 6666.033425153326, 3683.134463401152, 3709.8330575124182, 3719.0702324418894, 3741.3639681254253, 3741.85032598693, 1267.6070418170398, 1270.5680068776476, 1292.9353532323346, 1293.3468598357956, 1327.4159369877223, 534.9732513374315, 535.8767483478822, 541.8401571536327, 553.8670719027485, 584.7690162385834, 11682.649520514398, 12764.872351276554, 12921.870781292255, 13432.261225632488, 13458.0, 560.0674876330863, 568.0626965506947, 577.5956830218863, 580.8896309701144, 583.4894467341077, 7142.964285178541, 7223.735846226889, 7481.438892083115, 7499.287567681062, 7608.619569021526, 592442.0, 609216.0, 610839.0, 634033.0, 638993.0, 82965.0, 84635.0, 84682.0, 87191.0, 87384.0, 603.9003564411911, 614.9692515374303, 620.0606081786008, 621.0249907645044, 621.0466933257518, 11883.821742673694, 12261.034981151033, 12467.127301088836, 12475.126741128033, 12732.490700371882, 38389.0, 38591.0, 39224.60775392209, 39250.80374598223, 39274.214515708954, 48805.755971219914, 49249.507504925925, 53744.0, 53985.0, 55958.0, 7591.962040189764, 7682.540317339687, 7683.615819209129, 7722.729704460542, 7767.72812951544, 11434.142439316918, 11754.177207595729, 13148.539801106916, 13476.93261533686, 13569.389377478235, 11172.720681983015, 11813.704657383634, 11851.407429628312, 11852.0, 11908.04735621131, 11195.72010699739, 11312.6040588579, 11335.206535542433, 11369.488373023069, 11609.30344179352, 11792.23350482216, 11905.226160299553, 11910.464029118884, 11945.820812687643, 12237.0822188338, 7701.152873184057, 7798.415118865994, 7815.374770018499, 7860.0, 7909.762707118795, 12104.152709310263, 12192.268463892195, 12229.93885030569, 12242.877571224173, 12429.0], "unit": "ms", "name": "jquery.html", "value": 7730.627491311697}, {"lowerIsBetter": false, "replicates": [1563.7498000319952, 1568.451042135252, 1826.2603645523568, 1890.5084677983725, 1890.9716354254683, 7600.315971562558, 7716.228377162295, 8291.792705182366, 8468.830623387536, 8471.534065626396, 7905.565193914347, 8041.195880411956, 8097.392695547828, 8136.837263254732, 8176.877346839802, 2436.6832311799485, 2491.3397949543387, 2491.825572209946, 2494.8128890333205, 2495.214007587613, 2130.456733532947, 2163.6105501009893, 2465.6055031195015, 2474.7277799442136, 2544.0, 2469.061756532524, 2495.0643508684243, 2506.4736405354897, 2541.3265484646586, 2542.7965762738936, 2394.7126344838557, 2399.712034555847, 2427.4174198192395, 2427.417419819248, 2430.222328854767, 2472.505498900227, 2497.675302210719, 2499.4126380300613, 2500.362407586072, 2501.187114187896, 8416.789580260482, 8510.957445212796, 8515.361347898932, 8519.0, 8525.914740852573, 5162.380514338303, 5203.895922081575, 5216.165413533817, 5216.426193118754, 5250.44870288618, 3329.6337402885665, 3418.572678415198, 3438.6905178534053, 3441.9655803441897, 3468.4277094279414, 1173.4719376280707, 1194.814803705427, 1197.239752756997, 1221.126894270592, 1230.9721382645503, 11680.0655947524, 11798.764024719543, 11826.822597660956, 11828.639706433783, 11833.0, 4806.423229212517, 4825.227963525889, 4854.660173787801, 4925.433575138905, 4937.728424936591, 9355.859662105075, 9376.718698439057, 9397.483138427315, 9427.387219830689, 9436.480993545283, 5112.028714544224, 5117.488251174853, 5123.897522049539, 5127.1540195867265, 5130.563902068291, 4737.360456338351, 4740.7392593407, 4747.86051347674, 4750.548697873696, 4751.239801631722, 3311.519829624739, 3785.7733787111197, 3790.298794722985, 3809.142942837839, 3821.7133714971487, 1090.547422819537, 1149.6953307373553, 1163.2497039409534, 1175.670812172593, 1194.7491026884452, 1119.7088756923097, 1160.8200728887036, 1167.8773728758529, 1449.8840092792552, 1515.1515151514966, 7999.36005119589, 8035.357171426272, 8038.437309388287, 8058.717944871902, 8068.919310806817, 786.2648423723837, 794.412135020081, 796.4584082823735, 797.9361651067901, 909.7816524034184, 6312.558120931582, 6351.926199703165, 6415.518836087312, 6428.260750013808, 6438.0, 10116.747081323027, 10339.689809305733, 10360.896391036144, 10382.221333399873, 10416.5833366666, 10095.697129086138, 10300.948495257475, 10325.74185645365, 10331.586736530606, 10351.378917264989, 7959.801004974922, 8024.398170137263, 8026.638801254075, 8035.477693949874, 8040.919590804017, 7657.617119143909, 7666.769996900102, 7698.34564062061, 7733.651985660546, 7849.5682737447705, 9153.771155720893, 9274.397164184307, 9342.813143737223, 9347.953260233928, 9369.765755855886, 9338.252939764938, 9485.478298693639, 9508.144267016001, 9591.088846559565, 9614.9038509614, 7018.6490675465, 7069.71721131149, 7085.0, 7088.362047415551, 7089.113860767404, 7479.738209162653, 7637.198094200029, 7984.481008734414, 8145.71489997871, 8164.346852251924, 7483.438742094474, 7621.3902887769955, 7666.38668906475, 7714.961425192838, 7814.179511151247, 7506.774796756106, 7552.962235188789, 7621.961890190513, 7687.846243075219, 7695.615219239127, 7636.656350464354, 7657.272559106876, 7697.076350837935, 7811.648475818715, 7829.217078292125, 6839.897401538881, 6884.345987131214, 6898.448124149955, 6899.344562266577, 6899.517033807585, 7076.2923707628825, 7132.8216794578475, 7138.14342278909, 7164.67758950838, 7191.460640452092], "unit": "ms", "name": "mootools.html", "value": 4823.975460857019}, {"lowerIsBetter": false, "replicates": [358.0047468038852, 360.65737549328145, 361.45420415173083, 363.6781448418149, 363.7890023786204, 5710.400407957157, 5834.241548598677, 5843.970780146099, 5875.32433770116, 5883.6763977981245, 5685.658860468375, 5787.855303617412, 5789.189513468107, 5816.389279125694, 5818.0, 4580.0, 4596.977015114937, 4614.584687378136, 4615.376924115235, 4622.8150873965005, 4428.689991700582, 4501.077279157781, 4513.706609070417, 4609.746463944499, 4614.215583350839, 4558.384618076567, 4561.635069194456, 4574.016586433916, 4592.839250626229, 4593.885152871171, 4527.343535187412, 4538.546145385468, 4553.203189441851, 4560.817567297304, 4564.018735971748, 4046.615571520701, 4050.3721923101966, 4057.431959525669, 4060.3909413587903, 4060.959390406117, 5562.221289019541, 5645.125005624135, 5647.265855438808, 5660.943390566083, 5663.915041274384, 5296.523312901819, 5298.072837253465, 5313.335833020872, 5313.867153321159, 5318.388385335697, 5942.97028514859, 6258.968705156445, 6261.937380626181, 6264.060390941395, 6273.247210334744, 4325.610695037431, 4387.42963414754, 4421.712588681726, 4427.225235583792, 4435.401220835211, 6296.370362963713, 6359.55483116182, 6394.840128996766, 6409.4551963083195, 6419.0, 4540.205464043779, 4545.38637283969, 4565.840195593205, 4568.634509239253, 4574.519675434098, 4565.315202719618, 4627.375304333872, 4637.1653102441205, 4647.721136731807, 4686.835960741358, 5299.8410047698635, 5304.92042619361, 5309.946900531023, 5311.575073994071, 5312.946870531246, 6237.002079667232, 6237.220347456568, 6239.220097487814, 6244.37556244381, 6256.43692067707, 1656.403694669918, 1675.9078250696084, 1680.857127144182, 1681.6048228666255, 1682.4616122840819, 1127.3799410324289, 1130.0, 1131.6548452722, 1138.317009794117, 1164.7030007348071, 6044.395560443921, 6059.21230240066, 6062.302835174011, 6064.575479716465, 6072.908906366408, 6310.936890631035, 6365.204349456318, 6369.904451433232, 6376.936230637727, 6389.488840892717, 5944.554158438134, 5996.580239383288, 6054.939450605526, 6057.757689692451, 6063.514918806485, 3515.7870534666013, 3537.0, 3537.4340105582983, 3540.061883600848, 3542.574891013095, 6480.675966201671, 6482.286948435668, 6487.805365839033, 6491.642959637265, 6492.318306577836, 6498.805035848932, 6504.707288172043, 6508.9349106508325, 6510.934890651128, 6517.9348206517325, 6441.613503189824, 6654.301298363699, 6663.200415950117, 6675.933240667531, 6677.09859169006, 6266.37336266388, 6347.3652634738, 6481.157449531531, 6482.448991835747, 6494.512911531559, 6271.090691849748, 6339.017452294902, 6364.6181229126405, 6374.617522948638, 6375.203099612549, 6583.111279977142, 6603.0, 6606.405423511907, 6618.172728408949, 6621.50338724588, 4525.981654127795, 4566.0, 4568.223402021731, 4573.176828170961, 4573.519780423007, 6366.458850997532, 6376.808695739135, 6380.744770209325, 6386.552941294251, 6388.329225431263, 6274.184356033869, 6274.435300822948, 6277.3408792078, 6277.686115694289, 6285.591436556792, 6213.471854892204, 6263.248410190807, 6263.279722831932, 6269.811905642838, 6270.404311590391, 6194.783182588588, 6201.193844800147, 6206.565540412308, 6207.255129384503, 6208.658523781055, 6265.96867015662, 6289.779857704958, 6301.180846489927, 6308.400701933309, 6328.0, 6096.146539484387, 6112.32764395925, 6174.598651087665, 6177.2587289525545, 6183.690815459299], "unit": "ms", "name": "prototype.html", "value": 4763.02120074056}, {"lowerIsBetter": false, "replicates": [833.6582001379436, 870.5690683111859, 889.6041261638566, 938.1322276893872, 957.9521023948801, 15041.699166016673, 15533.301001454933, 15536.145511996836, 15559.611009724735, 15567.532974010785, 14195.858041419582, 14286.785698214535, 14375.928120359384, 14376.928115359435, 14385.280735963186, 905.7871400220943, 913.2465715784471, 920.3787443475661, 921.1709461484684, 922.6447817590242, 895.852184389575, 903.1645727701882, 904.8823652925144, 905.7780843693305, 906.8730377747121, 952.3952290295642, 960.0399600399601, 961.8941916389226, 962.0331566775416, 962.4081190068127, 954.1603389017689, 954.346272803132, 955.1833182628822, 955.5317894231777, 956.3974695941547, 703.8275622472527, 705.5061456980135, 705.7424040225333, 705.8941158826166, 706.3113464372248, 14091.154530728087, 14145.434182632682, 14179.503717369842, 14243.715125697532, 14266.429342826275, 11339.943300283447, 11598.71003224926, 11661.300321980709, 12015.879841201564, 12029.338386388745, 10063.798724025479, 10459.320144190604, 10631.362118272928, 10631.468426578718, 10705.518251678694, 3722.5532936047575, 3726.81365931705, 3758.774473531597, 3803.315403227418, 3812.390017597171, 44976.77511612454, 46307.768461157815, 50092.24861627115, 50192.74903625495, 51757.7412112937, 10518.368897866152, 10752.301100428447, 10864.130869530418, 10908.672739817817, 11132.666020019413, 13259.270740109387, 13415.865841341656, 21044.894775526023, 21053.57892842165, 21061.789382105984, 7349.55902645843, 7406.370458510979, 7526.849463010709, 7557.2820582044615, 7648.655810488542, 4446.133004064176, 4876.926846097312, 4892.926606100911, 4965.106280869406, 4976.5023497649945, 3063.525153601151, 3067.76991725617, 3077.9076627700756, 3082.722554970019, 3087.212760745995, 488.9828855990023, 493.26996045852337, 501.79175642108845, 502.51507295460056, 506.501096420026, 711.7864640607797, 724.5401860682952, 752.1913942511821, 755.8948328903977, 760.068915578412, 8718.215360617574, 8778.34162437807, 8834.337424693045, 8879.866801997976, 8897.288216942628, 588.9823305300848, 658.0819756439739, 742.6101296819105, 750.572173860905, 757.1293013034943, 4039.151778126626, 4048.959510404917, 4123.628873401408, 4157.605027522381, 4195.349720793282, 65746.67126664336, 68270.65864670645, 69372.653136735, 69613.0, 69890.65054674796, 46620.0, 54202.45797541974, 57539.424605753404, 60222.698886505284, 60241.0, 52081.47918520766, 53529.19706204488, 53887.461125389025, 54441.1833822493, 54816.72591637016, 9012.188902998761, 9055.139761722627, 9166.67916622915, 9185.77035574116, 9399.577019034023, 40734.16696248617, 41242.38136427896, 41733.0, 41803.58196417997, 42285.15429691327, 49003.26495102505, 51795.74102129465, 53036.0, 53307.73346133244, 53555.73222133864, 8967.730968070968, 8970.37207395476, 8998.325125615736, 9020.503872287087, 9234.815303693755, 12300.630981070582, 12835.294058826854, 12861.485540578273, 13019.21884686884, 13367.532136375568, 11283.210175287652, 11570.363630000094, 11623.6512904613, 11634.36011019402, 11800.350980696145, 11023.61417350389, 11034.668959931216, 11088.501017454073, 11117.27737697047, 11221.887781122085, 10960.725981850199, 11069.169812264274, 11150.442477876237, 11270.267432617182, 11282.0, 9854.0, 9892.455914924749, 9898.851517227104, 9931.0, 10546.156307495228, 9655.855162172433, 9764.218862491125, 9828.262880283864, 9887.802243954937, 9955.601775928882], "unit": "ms", "name": "yui.html", "value": 6670.73972010222}], "name": "dromaeo_css", "value": 7226.944481026582}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [109.0, 112.0, 102.0, 112.0, 112.0, 111.0, 99.0, 109.0, 100.0, 108.0], "unit": "ms", "name": "ai-astar", "value": 107.4}, {"lowerIsBetter": true, "replicates": [152.0, 125.0, 146.0, 161.0, 131.0, 159.0, 147.0, 126.0, 158.0, 123.0], "unit": "ms", "name": "audio-beat-detection", "value": 142.8}, {"lowerIsBetter": true, "replicates": [161.0, 162.0, 162.0, 162.0, 162.0, 163.0, 161.0, 164.0, 160.0, 163.0], "unit": "ms", "name": "audio-dft", "value": 162.0}, {"lowerIsBetter": true, "replicates": [71.0, 72.0, 71.0, 148.0, 72.0, 72.0, 72.0, 71.0, 148.0, 72.0], "unit": "ms", "name": "audio-fft", "value": 86.9}, {"lowerIsBetter": true, "replicates": [91.0, 90.0, 138.0, 90.0, 90.0, 90.0, 133.0, 88.0, 90.0, 134.0], "unit": "ms", "name": "audio-oscillator", "value": 103.4}, {"lowerIsBetter": true, "replicates": [110.0, 110.0, 109.0, 109.0, 109.0, 110.0, 110.0, 110.0, 109.0, 110.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 109.6}, {"lowerIsBetter": true, "replicates": [147.0, 145.0, 144.0, 146.0, 145.0, 145.0, 145.0, 145.0, 145.0, 144.0], "unit": "ms", "name": "imaging-darkroom", "value": 145.1}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 96.0, 96.0, 95.0, 96.0, 95.0, 96.0, 95.0, 96.0], "unit": "ms", "name": "imaging-desaturate", "value": 95.7}, {"lowerIsBetter": true, "replicates": [53.0, 54.0, 55.0, 55.0, 57.0, 55.0, 57.0, 63.0, 54.0, 54.0], "unit": "ms", "name": "json-parse-financial", "value": 55.7}, {"lowerIsBetter": true, "replicates": [63.0, 64.0, 64.0, 64.0, 63.0, 64.0, 64.0, 63.0, 67.0, 64.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 64.0}, {"lowerIsBetter": true, "replicates": [77.0, 76.0, 78.0, 78.0, 77.0, 77.0, 76.0, 78.0, 77.0, 77.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 77.1}, {"lowerIsBetter": true, "replicates": [115.0, 111.0, 108.0, 122.0, 114.0, 110.0, 124.0, 111.0, 110.0, 107.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 113.2}, {"lowerIsBetter": true, "replicates": [135.0, 137.0, 133.0, 136.0, 141.0, 138.0, 136.0, 137.0, 135.0, 129.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 135.7}, {"lowerIsBetter": true, "replicates": [62.0, 62.0, 63.0, 64.0, 63.0, 64.0, 63.0, 60.0, 64.0, 61.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 62.6}], "name": "kraken", "value": 1461.2}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [164.98927569707968], "unit": "score", "name": "Richards", "value": 213.96542200000005}, {"lowerIsBetter": false, "replicates": [164.63615409944023], "unit": "score", "name": "DeltaBlue", "value": 401.60073199999994}, {"lowerIsBetter": false, "replicates": [279.79854504756577], "unit": "score", "name": "Encrypt", "value": 951.330894}, {"lowerIsBetter": false, "replicates": [5005.0], "unit": "score", "name": "Decrypt", "value": 53.18301698301701}, {"lowerIsBetter": false, "replicates": [1003.0090270812437], "unit": "score", "name": "RayTrace", "value": 737.7690329999998}, {"lowerIsBetter": false, "replicates": [551.8763796909492], "unit": "score", "name": "Earley", "value": 1207.6309559999997}, {"lowerIsBetter": false, "replicates": [10447.916666666666], "unit": "score", "name": "Boyer", "value": 63.78908075772688}, {"lowerIsBetter": false, "replicates": [23627.906976744187], "unit": "score", "name": "RegExp", "value": 38.55546751968505}, {"lowerIsBetter": false, "replicates": [533.0490405117271], "unit": "score", "name": "Splay", "value": 152.87711600000006}, {"lowerIsBetter": false, "replicates": [4817.307692307692], "unit": "score", "name": "NavierStokes", "value": 308.055888223553}], "name": "v8_7", "value": 23270.155500807392}]} 14:17:36 INFO - RETURN: dromaeo_css: 7226.94 14:17:36 INFO - RETURN: kraken: 1461.20 14:17:36 INFO - RETURN: v8_7: 23270.16 14:17:36 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,53,35]]", "result": "23270.16"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,53,35]]", "result": "1461.20"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,53,35]]", "result": "7226.94"}}} 14:17:36 INFO - Return code: 0 14:17:36 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 14:17:36 INFO - # TBPL SUCCESS # 14:17:36 INFO - Running post-action listener: _resource_record_post_action 14:17:36 INFO - Running post-run listener: _resource_record_post_run 14:17:37 INFO - Total resource usage - Wall time: 1222s; CPU: 13.0%; Read bytes: 319488; Write bytes: 280993792; Read time: 124; Write time: 177808 14:17:37 INFO - install - Wall time: 15s; CPU: 13.0%; Read bytes: 0; Write bytes: 24526848; Read time: 0; Write time: 5260 14:17:37 INFO - run-tests - Wall time: 1208s; CPU: 13.0%; Read bytes: 319488; Write bytes: 256114688; Read time: 124; Write time: 172316 14:17:37 INFO - Running post-run listener: _upload_blobber_files 14:17:37 INFO - Blob upload gear active. 14:17:37 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 14:17:37 INFO - Copying logs to upload dir... 14:17:37 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1266.806027 ========= master_lag: -0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 6 secs) (at 2016-01-07 14:17:36.485785) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2016-01-07 14:17:36.489429) ========= 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=52faae308a556c440401f8e5000001e8-1452203743.775068-309818213 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1452195326/firefox-44.0.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.009956 build_url: 'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1452195326/firefox-44.0.en-US.linux-x86_64.tar.bz2' ========= master_lag: 0.04 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2016-01-07 14:17:36.540695) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-07 14:17:36.541054) ========= 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=52faae308a556c440401f8e5000001e8-1452203743.775068-309818213 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004448 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-07 14:17:36.590833) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-07 14:17:36.591168) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-07 14:17:36.591468) ========= ========= Total master_lag: 0.20 =========